builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1501084333.62 results: success (0) revision: 388d81ed93fa640f91d155f36254667c734157cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:13.617076) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:13.617579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:13.617874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:13.637349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:13.637754) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-26 08:52:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-07-26 08:52:14 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:13.820466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:13.821056) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019102 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:13.880376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-26 08:52:13.883710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 388d81ed93fa640f91d155f36254667c734157cf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 388d81ed93fa640f91d155f36254667c734157cf --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-26 08:52:15,023 truncating revision to first 12 chars 2017-07-26 08:52:15,023 Setting DEBUG logging. 2017-07-26 08:52:15,023 attempt 1/10 2017-07-26 08:52:15,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/388d81ed93fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-26 08:52:15,951 unpacking tar archive at: mozilla-central-388d81ed93fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.233690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-26 08:52:15.132235) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:15.132554) ========= script_repo_revision: 388d81ed93fa640f91d155f36254667c734157cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:15.132947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:15.133210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 08:52:15.141750) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-26 08:52:15.142084) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:52:16 INFO - MultiFileLogger online at 20170726 08:52:16 in /builds/slave/test 08:52:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:52:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:16 INFO - {'append_to_log': False, 08:52:16 INFO - 'base_work_dir': '/builds/slave/test', 08:52:16 INFO - 'blob_upload_branch': 'Firefox', 08:52:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:16 INFO - 'branch': 'Firefox', 08:52:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:16 INFO - 'code_coverage': False, 08:52:16 INFO - 'config_files': ('talos/linux_config.py',), 08:52:16 INFO - 'default_actions': ('clobber', 08:52:16 INFO - 'read-buildbot-config', 08:52:16 INFO - 'download-and-extract', 08:52:16 INFO - 'populate-webroot', 08:52:16 INFO - 'create-virtualenv', 08:52:16 INFO - 'install', 08:52:16 INFO - 'setup-mitmproxy', 08:52:16 INFO - 'run-tests'), 08:52:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:16 INFO - 'disable_ccov_upload': False, 08:52:16 INFO - 'download_minidump_stackwalk': True, 08:52:16 INFO - 'download_symbols': 'ondemand', 08:52:16 INFO - 'enable_stylo': False, 08:52:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:16 INFO - 'gecko_profile': False, 08:52:16 INFO - 'gecko_profile_interval': 0, 08:52:16 INFO - 'installer_path': 'installer.exe', 08:52:16 INFO - 'log_level': 'info', 08:52:16 INFO - 'log_name': 'talos', 08:52:16 INFO - 'log_to_console': True, 08:52:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:52:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:52:16 INFO - 'opt_config_files': (), 08:52:16 INFO - 'pip_index': False, 08:52:16 INFO - 'suite': 'dromaeojs-e10s', 08:52:16 INFO - 'system_bits': '32', 08:52:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:16 INFO - 'title': 'talos-linux64-ix-051', 08:52:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:16 INFO - 'use_talos_json': True, 08:52:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:16 INFO - 'work_dir': 'build'} 08:52:16 INFO - [mozharness: 2017-07-26 15:52:16.386322Z] Running clobber step. 08:52:16 INFO - Running pre-action listener: _resource_record_pre_action 08:52:16 INFO - Running main action method: clobber 08:52:16 INFO - rmtree: /builds/slave/test/build 08:52:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:17 INFO - Running post-action listener: _resource_record_post_action 08:52:17 INFO - [mozharness: 2017-07-26 15:52:17.936126Z] Finished clobber step (success) 08:52:17 INFO - [mozharness: 2017-07-26 15:52:17.936228Z] Running read-buildbot-config step. 08:52:17 INFO - Running pre-action listener: _resource_record_pre_action 08:52:17 INFO - Running main action method: read_buildbot_config 08:52:17 INFO - Using buildbot properties: 08:52:17 INFO - { 08:52:17 INFO - "project": "", 08:52:17 INFO - "product": "firefox", 08:52:17 INFO - "who": "Callek@gmail.com", 08:52:17 INFO - "installer_path": "public/build/target.tar.bz2", 08:52:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:52:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:52:17 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:52:17 INFO - "stage_platform": "linux64-stylo", 08:52:17 INFO - "basedir": "/builds/slave/test", 08:52:17 INFO - "buildnumber": 4, 08:52:17 INFO - "platform": "ubuntu64_hw_stylo", 08:52:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:52:17 INFO - "slavebuilddir": "test", 08:52:17 INFO - "taskId": "QhSw978DQU-99mscXrzqDQ", 08:52:17 INFO - "branch": "mozilla-central", 08:52:17 INFO - "script_repo_revision": "production", 08:52:17 INFO - "revision": "388d81ed93fa640f91d155f36254667c734157cf", 08:52:17 INFO - "slavename": "talos-linux64-ix-051", 08:52:17 INFO - "repo_path": "mozilla-central" 08:52:17 INFO - } 08:52:17 INFO - Finding installer, test and symbols from parent task. 08:52:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhSw978DQU-99mscXrzqDQ'}, attempt #1 08:52:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhSw978DQU-99mscXrzqDQ'}, attempt #1 08:52:19 INFO - Task dependencies: McIpE5nYSU6x4xohkK7ZTQ 08:52:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ'}, attempt #1 08:52:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.tar.bz2 08:52:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/test_packages.json 08:52:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.crashreporter-symbols.zip 08:52:19 INFO - Running post-action listener: _resource_record_post_action 08:52:19 INFO - [mozharness: 2017-07-26 15:52:19.535727Z] Finished read-buildbot-config step (success) 08:52:19 INFO - [mozharness: 2017-07-26 15:52:19.535950Z] Running download-and-extract step. 08:52:19 INFO - Running pre-action listener: _resource_record_pre_action 08:52:19 INFO - Running main action method: download_and_extract 08:52:19 INFO - mkdir: /builds/slave/test/build/tests 08:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:19 INFO - trying https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.test_packages.json 08:52:19 INFO - Downloading https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:52:20 INFO - Downloaded 989 bytes. 08:52:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:52:20 INFO - Using the following test package requirements: 08:52:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:52:20 INFO - u'common': [u'target.common.tests.zip'], 08:52:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:52:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:52:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:52:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:52:20 INFO - u'mozbase': [u'target.common.tests.zip'], 08:52:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:52:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:52:20 INFO - u'web-platform': [u'target.common.tests.zip', 08:52:20 INFO - u'target.web-platform.tests.tar.gz'], 08:52:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:52:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:52:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.common.tests.zip 08:52:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:52:20 INFO - Fetch https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.common.tests.zip into memory 08:52:21 INFO - Content-Length response header: 72522421 08:52:21 INFO - Bytes received: 72522421 08:52:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:52:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.common.tests.zip 08:52:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:52:32 INFO - Fetch https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.common.tests.zip into memory 08:52:34 INFO - Content-Length response header: 72522421 08:52:34 INFO - Bytes received: 72522421 08:52:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.talos.tests.zip 08:52:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:52:46 INFO - Fetch https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.talos.tests.zip into memory 08:52:46 INFO - Content-Length response header: 14496448 08:52:46 INFO - Bytes received: 14496448 08:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:47 INFO - trying https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.tar.bz2 08:52:47 INFO - Downloading https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:52:48 INFO - Downloaded 62051695 bytes. 08:52:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.tar.bz2 08:52:48 INFO - mkdir: /builds/slave/test/properties 08:52:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:48 INFO - Contents: 08:52:48 INFO - build_url:https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.tar.bz2 08:52:48 INFO - Running post-action listener: _resource_record_post_action 08:52:48 INFO - Running post-action listener: set_extra_try_arguments 08:52:48 INFO - [mozharness: 2017-07-26 15:52:48.322022Z] Finished download-and-extract step (success) 08:52:48 INFO - [mozharness: 2017-07-26 15:52:48.322120Z] Running populate-webroot step. 08:52:48 INFO - Running pre-action listener: _resource_record_pre_action 08:52:48 INFO - Running main action method: populate_webroot 08:52:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:52:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:52:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:52:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:52:48 INFO - 'tests': ['damp', 'tps']}, 08:52:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:52:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:52:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:52:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:52:48 INFO - 'ts_paint', 08:52:48 INFO - 'tpaint', 08:52:48 INFO - 'sessionrestore', 08:52:48 INFO - 'sessionrestore_many_windows', 08:52:48 INFO - 'sessionrestore_no_auto_restore', 08:52:48 INFO - 'tabpaint']}, 08:52:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:52:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:52:48 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:52:48 INFO - 'talos_options': ['--mitmproxy', 08:52:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:52:48 INFO - '--firstNonBlankPaint'], 08:52:48 INFO - 'tests': ['quantum_pageload_google', 08:52:48 INFO - 'quantum_pageload_youtube', 08:52:48 INFO - 'quantum_pageload_amazon', 08:52:48 INFO - 'quantum_pageload_facebook']}, 08:52:48 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:52:48 INFO - 'talos_options': ['--stylo', 08:52:48 INFO - '--mitmproxy', 08:52:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:52:48 INFO - '--firstNonBlankPaint'], 08:52:48 INFO - 'tests': ['quantum_pageload_google', 08:52:48 INFO - 'quantum_pageload_youtube', 08:52:48 INFO - 'quantum_pageload_amazon', 08:52:48 INFO - 'quantum_pageload_facebook']}, 08:52:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:52:48 INFO - 'tsvgr_opacity', 08:52:48 INFO - 'tart', 08:52:48 INFO - 'tscrollx', 08:52:48 INFO - 'cart', 08:52:48 INFO - 'tsvg_static']}, 08:52:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:52:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:52:48 INFO - 'talos_options': ['--xperf_path', 08:52:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:48 INFO - 'tests': ['tp5n']}}} 08:52:48 INFO - Running post-action listener: _resource_record_post_action 08:52:48 INFO - [mozharness: 2017-07-26 15:52:48.329545Z] Finished populate-webroot step (success) 08:52:48 INFO - [mozharness: 2017-07-26 15:52:48.329636Z] Running create-virtualenv step. 08:52:48 INFO - Running pre-action listener: _resource_record_pre_action 08:52:48 INFO - Running main action method: create_virtualenv 08:52:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:48 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 08:52:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:52:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:48 INFO - Using real prefix '/usr' 08:52:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:52:50 INFO - Installing pip.................done. 08:52:50 INFO - Return code: 0 08:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:52:51 INFO - Reading from file tmpfile_stdout 08:52:51 INFO - Output received: 08:52:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:52:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 08:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:52:51 INFO - Using env: {'DISPLAY': ':0', 08:52:51 INFO - 'HOME': '/home/cltbld', 08:52:51 INFO - 'LANG': 'en_US.UTF-8', 08:52:51 INFO - 'LANGUAGE': 'en_US:en', 08:52:51 INFO - 'LOGNAME': 'cltbld', 08:52:51 INFO - 'MAIL': '/var/mail/cltbld', 08:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:51 INFO - 'MOZ_NO_REMOTE': '1', 08:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:51 INFO - 'NO_EM_RESTART': '1', 08:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:51 INFO - 'PWD': '/builds/slave/test', 08:52:51 INFO - 'SHELL': '/bin/bash', 08:52:51 INFO - 'SHLVL': '1', 08:52:51 INFO - 'TERM': 'linux', 08:52:51 INFO - 'TMOUT': '86400', 08:52:51 INFO - 'USER': 'cltbld', 08:52:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:51 INFO - '_': '/tools/buildbot/bin/python'} 08:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:51 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 08:52:51 INFO - Cleaning up... 08:52:51 INFO - Return code: 0 08:52:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 08:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:52:51 INFO - Using env: {'DISPLAY': ':0', 08:52:51 INFO - 'HOME': '/home/cltbld', 08:52:51 INFO - 'LANG': 'en_US.UTF-8', 08:52:51 INFO - 'LANGUAGE': 'en_US:en', 08:52:51 INFO - 'LOGNAME': 'cltbld', 08:52:51 INFO - 'MAIL': '/var/mail/cltbld', 08:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:51 INFO - 'MOZ_NO_REMOTE': '1', 08:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:51 INFO - 'NO_EM_RESTART': '1', 08:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:51 INFO - 'PWD': '/builds/slave/test', 08:52:51 INFO - 'SHELL': '/bin/bash', 08:52:51 INFO - 'SHLVL': '1', 08:52:51 INFO - 'TERM': 'linux', 08:52:51 INFO - 'TMOUT': '86400', 08:52:51 INFO - 'USER': 'cltbld', 08:52:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:51 INFO - '_': '/tools/buildbot/bin/python'} 08:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:51 INFO - Downloading/unpacking psutil>=3.1.1 08:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:52:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:52 INFO - Installing collected packages: psutil 08:52:52 INFO - Running setup.py install for psutil 08:52:52 INFO - building 'psutil._psutil_linux' extension 08:52:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:52:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:52:53 INFO - building 'psutil._psutil_posix' extension 08:52:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:52:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:52:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:53 INFO - Successfully installed psutil 08:52:53 INFO - Cleaning up... 08:52:53 INFO - Return code: 0 08:52:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:53 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/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 08:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:52:53 INFO - Using env: {'DISPLAY': ':0', 08:52:53 INFO - 'HOME': '/home/cltbld', 08:52:53 INFO - 'LANG': 'en_US.UTF-8', 08:52:53 INFO - 'LANGUAGE': 'en_US:en', 08:52:53 INFO - 'LOGNAME': 'cltbld', 08:52:53 INFO - 'MAIL': '/var/mail/cltbld', 08:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:53 INFO - 'MOZ_NO_REMOTE': '1', 08:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:53 INFO - 'NO_EM_RESTART': '1', 08:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:53 INFO - 'PWD': '/builds/slave/test', 08:52:53 INFO - 'SHELL': '/bin/bash', 08:52:53 INFO - 'SHLVL': '1', 08:52:53 INFO - 'TERM': 'linux', 08:52:53 INFO - 'TMOUT': '86400', 08:52:53 INFO - 'USER': 'cltbld', 08:52:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:53 INFO - '_': '/tools/buildbot/bin/python'} 08:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:54 INFO - Installing collected packages: mozsystemmonitor 08:52:54 INFO - Running setup.py install for mozsystemmonitor 08:52:54 INFO - Successfully installed mozsystemmonitor 08:52:54 INFO - Cleaning up... 08:52:54 INFO - Return code: 0 08:52:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 08:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:52:54 INFO - Using env: {'DISPLAY': ':0', 08:52:54 INFO - 'HOME': '/home/cltbld', 08:52:54 INFO - 'LANG': 'en_US.UTF-8', 08:52:54 INFO - 'LANGUAGE': 'en_US:en', 08:52:54 INFO - 'LOGNAME': 'cltbld', 08:52:54 INFO - 'MAIL': '/var/mail/cltbld', 08:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:54 INFO - 'MOZ_NO_REMOTE': '1', 08:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:54 INFO - 'NO_EM_RESTART': '1', 08:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:54 INFO - 'PWD': '/builds/slave/test', 08:52:54 INFO - 'SHELL': '/bin/bash', 08:52:54 INFO - 'SHLVL': '1', 08:52:54 INFO - 'TERM': 'linux', 08:52:54 INFO - 'TMOUT': '86400', 08:52:54 INFO - 'USER': 'cltbld', 08:52:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:54 INFO - '_': '/tools/buildbot/bin/python'} 08:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:55 INFO - Downloading/unpacking jsonschema==2.5.1 08:52: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 08:52: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 08:52: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 08:52: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 08:52:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:56 INFO - warning: no files found matching '*.txt' 08:52:56 INFO - no previously-included directories found matching 'build' 08:52:56 INFO - no previously-included directories found matching 'dist' 08:52:56 INFO - no previously-included directories found matching '.git*' 08:52:56 INFO - Installing collected packages: jsonschema, functools32 08:52:56 INFO - Running setup.py install for functools32 08:52:56 INFO - warning: no files found matching '*.txt' 08:52:56 INFO - no previously-included directories found matching 'build' 08:52:56 INFO - no previously-included directories found matching 'dist' 08:52:56 INFO - no previously-included directories found matching '.git*' 08:52:56 INFO - Successfully installed jsonschema functools32 08:52:56 INFO - Cleaning up... 08:52:56 INFO - Return code: 0 08:52:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:56 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:52:56 INFO - Using env: {'DISPLAY': ':0', 08:52:56 INFO - 'HOME': '/home/cltbld', 08:52:56 INFO - 'LANG': 'en_US.UTF-8', 08:52:56 INFO - 'LANGUAGE': 'en_US:en', 08:52:56 INFO - 'LOGNAME': 'cltbld', 08:52:56 INFO - 'MAIL': '/var/mail/cltbld', 08:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:56 INFO - 'MOZ_NO_REMOTE': '1', 08:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:56 INFO - 'NO_EM_RESTART': '1', 08:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:56 INFO - 'PWD': '/builds/slave/test', 08:52:56 INFO - 'SHELL': '/bin/bash', 08:52:56 INFO - 'SHLVL': '1', 08:52:56 INFO - 'TERM': 'linux', 08:52:56 INFO - 'TMOUT': '86400', 08:52:56 INFO - 'USER': 'cltbld', 08:52:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:56 INFO - '_': '/tools/buildbot/bin/python'} 08:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:56 INFO - Cleaning up... 08:52:56 INFO - Return code: 0 08:52:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:56 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/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 08:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:52:56 INFO - Using env: {'DISPLAY': ':0', 08:52:56 INFO - 'HOME': '/home/cltbld', 08:52:56 INFO - 'LANG': 'en_US.UTF-8', 08:52:56 INFO - 'LANGUAGE': 'en_US:en', 08:52:56 INFO - 'LOGNAME': 'cltbld', 08:52:56 INFO - 'MAIL': '/var/mail/cltbld', 08:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:56 INFO - 'MOZ_NO_REMOTE': '1', 08:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:56 INFO - 'NO_EM_RESTART': '1', 08:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:56 INFO - 'PWD': '/builds/slave/test', 08:52:56 INFO - 'SHELL': '/bin/bash', 08:52:56 INFO - 'SHLVL': '1', 08:52:56 INFO - 'TERM': 'linux', 08:52:56 INFO - 'TMOUT': '86400', 08:52:56 INFO - 'USER': 'cltbld', 08:52:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:56 INFO - '_': '/tools/buildbot/bin/python'} 08:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:58 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52: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 08:52: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 08:52: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 08:52: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 08:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52: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 08:52: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 08:52: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 08:52: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 08:52:58 INFO - Downloading docopt-0.6.1.tar.gz 08:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:58 INFO - Running setup.py install for blobuploader 08:52:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:58 INFO - Running setup.py install for requests 08:52:59 INFO - Running setup.py install for docopt 08:52:59 INFO - Successfully installed blobuploader requests docopt 08:52:59 INFO - Cleaning up... 08:52:59 INFO - Return code: 0 08:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:59 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/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:59 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:59 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:59 INFO - Using env: {'DISPLAY': ':0', 08:52:59 INFO - 'HOME': '/home/cltbld', 08:52:59 INFO - 'LANG': 'en_US.UTF-8', 08:52:59 INFO - 'LANGUAGE': 'en_US:en', 08:52:59 INFO - 'LOGNAME': 'cltbld', 08:52:59 INFO - 'MAIL': '/var/mail/cltbld', 08:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:59 INFO - 'MOZ_NO_REMOTE': '1', 08:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:59 INFO - 'NO_EM_RESTART': '1', 08:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:59 INFO - 'PWD': '/builds/slave/test', 08:52:59 INFO - 'SHELL': '/bin/bash', 08:52:59 INFO - 'SHLVL': '1', 08:52:59 INFO - 'TERM': 'linux', 08:52:59 INFO - 'TMOUT': '86400', 08:52:59 INFO - 'USER': 'cltbld', 08:52:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:59 INFO - '_': '/tools/buildbot/bin/python'} 08:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:59 INFO - Running setup.py (path:/tmp/pip-CWviNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:59 INFO - Running setup.py (path:/tmp/pip-fUPvK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:59 INFO - Running setup.py (path:/tmp/pip-KBJGVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:59 INFO - Running setup.py (path:/tmp/pip-ER01C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:59 INFO - Running setup.py (path:/tmp/pip-lMnYiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:59 INFO - Running setup.py (path:/tmp/pip-_tEjNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:59 INFO - Running setup.py (path:/tmp/pip-553Wdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:59 INFO - Running setup.py (path:/tmp/pip-xZWCdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:00 INFO - Running setup.py (path:/tmp/pip-abT11g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:00 INFO - Running setup.py (path:/tmp/pip-bkn_7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:00 INFO - Running setup.py (path:/tmp/pip-iTP28l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:00 INFO - Running setup.py (path:/tmp/pip-_1sDBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:00 INFO - Running setup.py (path:/tmp/pip-tQnGRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:00 INFO - Running setup.py (path:/tmp/pip-Jq2vNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:00 INFO - Running setup.py (path:/tmp/pip-FFyNtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:00 INFO - Running setup.py (path:/tmp/pip-4TgOXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:00 INFO - Running setup.py (path:/tmp/pip-5IYYOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:00 INFO - Running setup.py install for manifestparser 08:53:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:00 INFO - Running setup.py install for mozcrash 08:53:00 INFO - Running setup.py install for mozdebug 08:53:00 INFO - Running setup.py install for mozdevice 08:53:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for mozfile 08:53:01 INFO - Running setup.py install for mozhttpd 08:53:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for mozinfo 08:53:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for mozInstall 08:53:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for mozleak 08:53:01 INFO - Running setup.py install for mozlog 08:53:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for moznetwork 08:53:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Running setup.py install for mozprocess 08:53:01 INFO - Running setup.py install for mozprofile 08:53:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Running setup.py install for mozrunner 08:53:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Running setup.py install for mozscreenshot 08:53:02 INFO - Running setup.py install for moztest 08:53:02 INFO - Running setup.py install for mozversion 08:53:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:02 INFO - Cleaning up... 08:53:02 INFO - Return code: 0 08:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:02 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/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:02 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:53:02 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:02 INFO - Using env: {'DISPLAY': ':0', 08:53:02 INFO - 'HOME': '/home/cltbld', 08:53:02 INFO - 'LANG': 'en_US.UTF-8', 08:53:02 INFO - 'LANGUAGE': 'en_US:en', 08:53:02 INFO - 'LOGNAME': 'cltbld', 08:53:02 INFO - 'MAIL': '/var/mail/cltbld', 08:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:02 INFO - 'MOZ_NO_REMOTE': '1', 08:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:02 INFO - 'NO_EM_RESTART': '1', 08:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:02 INFO - 'PWD': '/builds/slave/test', 08:53:02 INFO - 'SHELL': '/bin/bash', 08:53:02 INFO - 'SHLVL': '1', 08:53:02 INFO - 'TERM': 'linux', 08:53:02 INFO - 'TMOUT': '86400', 08:53:02 INFO - 'USER': 'cltbld', 08:53:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:02 INFO - '_': '/tools/buildbot/bin/python'} 08:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:02 INFO - Running setup.py (path:/tmp/pip-FbEmsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:02 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)) 08:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:02 INFO - Running setup.py (path:/tmp/pip-dv1i9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:02 INFO - Running setup.py (path:/tmp/pip-N1gA5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:02 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)) 08:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:02 INFO - Running setup.py (path:/tmp/pip-34fd1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 08:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:02 INFO - Running setup.py (path:/tmp/pip-L_wPED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:03 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:03 INFO - Running setup.py (path:/tmp/pip-mmaBZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:03 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:03 INFO - Running setup.py (path:/tmp/pip-pC6lmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:03 INFO - Running setup.py (path:/tmp/pip-yDxP8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:03 INFO - Running setup.py (path:/tmp/pip-zoyY9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:03 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:03 INFO - Running setup.py (path:/tmp/pip-2vKqHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:03 INFO - Running setup.py (path:/tmp/pip-qsGQHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:03 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:03 INFO - Running setup.py (path:/tmp/pip-PEWwPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:03 INFO - Running setup.py (path:/tmp/pip-ry1J_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:03 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:03 INFO - Running setup.py (path:/tmp/pip-FvgFRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:03 INFO - Running setup.py (path:/tmp/pip-drzGg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:03 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:03 INFO - Running setup.py (path:/tmp/pip-JE76Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:03 INFO - Running setup.py (path:/tmp/pip-lyUjIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:03 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)) 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:03 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)) 08:53:03 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:03 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:53:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:03 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 08:53:03 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 08:53:03 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 08:53:03 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 08:53:04 INFO - Downloading blessings-1.6.tar.gz 08:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:05 INFO - Installing collected packages: blessings 08:53:05 INFO - Running setup.py install for blessings 08:53:05 INFO - Successfully installed blessings 08:53:05 INFO - Cleaning up... 08:53:05 INFO - Return code: 0 08:53:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:05 INFO - Reading from file tmpfile_stdout 08:53:05 INFO - Current package versions: 08:53:05 INFO - argparse == 1.2.1 08:53:05 INFO - blessings == 1.6 08:53:05 INFO - blobuploader == 1.2.4 08:53:05 INFO - docopt == 0.6.1 08:53:05 INFO - functools32 == 3.2.3-2 08:53:05 INFO - jsonschema == 2.5.1 08:53:05 INFO - manifestparser == 1.1 08:53:05 INFO - mozInstall == 1.13 08:53:05 INFO - mozcrash == 1.0 08:53:05 INFO - mozdebug == 0.1 08:53:05 INFO - mozdevice == 0.51 08:53:05 INFO - mozfile == 1.2 08:53:05 INFO - mozhttpd == 0.7 08:53:05 INFO - mozinfo == 0.10 08:53:05 INFO - mozleak == 0.1 08:53:05 INFO - mozlog == 3.5 08:53:05 INFO - moznetwork == 0.27 08:53:05 INFO - mozprocess == 0.25 08:53:05 INFO - mozprofile == 0.28 08:53:05 INFO - mozrunner == 6.13 08:53:05 INFO - mozscreenshot == 0.1 08:53:05 INFO - mozsystemmonitor == 0.3 08:53:05 INFO - moztest == 0.8 08:53:05 INFO - mozversion == 1.4 08:53:05 INFO - psutil == 3.1.1 08:53:05 INFO - requests == 1.2.3 08:53:05 INFO - wsgiref == 0.1.2 08:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:05 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/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:05 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:53:05 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:05 INFO - Using env: {'DISPLAY': ':0', 08:53:05 INFO - 'HOME': '/home/cltbld', 08:53:05 INFO - 'LANG': 'en_US.UTF-8', 08:53:05 INFO - 'LANGUAGE': 'en_US:en', 08:53:05 INFO - 'LOGNAME': 'cltbld', 08:53:05 INFO - 'MAIL': '/var/mail/cltbld', 08:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:05 INFO - 'MOZ_NO_REMOTE': '1', 08:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:05 INFO - 'NO_EM_RESTART': '1', 08:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:05 INFO - 'PWD': '/builds/slave/test', 08:53:05 INFO - 'SHELL': '/bin/bash', 08:53:05 INFO - 'SHLVL': '1', 08:53:05 INFO - 'TERM': 'linux', 08:53:05 INFO - 'TMOUT': '86400', 08:53:05 INFO - 'USER': 'cltbld', 08:53:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:05 INFO - '_': '/tools/buildbot/bin/python'} 08:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:05 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)) 08:53:05 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)) 08:53:05 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)) 08:53:05 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)) 08:53:05 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)) 08:53:05 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)) 08:53:05 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)) 08:53:05 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)) 08:53:05 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)) 08:53:05 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:53:05 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 08:53:05 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 08:53:05 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 08:53:05 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 08:53:06 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:53:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:53:07 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)) 08:53:07 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)) 08:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:53:07 INFO - Installing collected packages: marionette-driver, simplejson 08:53:07 INFO - Running setup.py install for marionette-driver 08:53:07 INFO - Running setup.py install for simplejson 08:53:07 INFO - building 'simplejson._speedups' extension 08:53:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:53:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:53:08 INFO - Successfully installed marionette-driver simplejson 08:53:08 INFO - Cleaning up... 08:53:08 INFO - Return code: 0 08:53:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22b01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:08 INFO - Using env: {'DISPLAY': ':0', 08:53:08 INFO - 'HOME': '/home/cltbld', 08:53:08 INFO - 'LANG': 'en_US.UTF-8', 08:53:08 INFO - 'LANGUAGE': 'en_US:en', 08:53:08 INFO - 'LOGNAME': 'cltbld', 08:53:08 INFO - 'MAIL': '/var/mail/cltbld', 08:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:08 INFO - 'MOZ_NO_REMOTE': '1', 08:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:08 INFO - 'NO_EM_RESTART': '1', 08:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:08 INFO - 'PWD': '/builds/slave/test', 08:53:08 INFO - 'SHELL': '/bin/bash', 08:53:08 INFO - 'SHLVL': '1', 08:53:08 INFO - 'TERM': 'linux', 08:53:08 INFO - 'TMOUT': '86400', 08:53:08 INFO - 'USER': 'cltbld', 08:53:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:08 INFO - '_': '/tools/buildbot/bin/python'} 08:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:08 INFO - Cleaning up... 08:53:08 INFO - Return code: 0 08:53:08 INFO - Running post-action listener: _resource_record_post_action 08:53:08 INFO - Running post-action listener: _start_resource_monitoring 08:53:08 INFO - Starting resource monitoring. 08:53:08 INFO - [mozharness: 2017-07-26 15:53:08.520208Z] Finished create-virtualenv step (success) 08:53:08 INFO - [mozharness: 2017-07-26 15:53:08.520681Z] Running install step. 08:53:08 INFO - Running pre-action listener: _resource_record_pre_action 08:53:08 INFO - Running main action method: install 08:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:08 INFO - Reading from file tmpfile_stdout 08:53:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:08 INFO - Reading from file tmpfile_stdout 08:53:08 INFO - Output received: 08:53:08 INFO - Usage: mozinstall [options] installer 08:53:08 INFO - Options: 08:53:08 INFO - -h, --help show this help message and exit 08:53:08 INFO - -d DEST, --destination=DEST 08:53:08 INFO - Directory to install application into. [default: 08:53:08 INFO - "/builds/slave/test"] 08:53:08 INFO - --app=APP Application being installed. [default: firefox] 08:53:08 INFO - mkdir: /builds/slave/test/build/application 08:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:53:26 INFO - Reading from file tmpfile_stdout 08:53:26 INFO - Output received: 08:53:26 INFO - /builds/slave/test/build/application/firefox/firefox 08:53:26 INFO - Running post-action listener: _resource_record_post_action 08:53:26 INFO - [mozharness: 2017-07-26 15:53:26.875298Z] Finished install step (success) 08:53:26 INFO - [mozharness: 2017-07-26 15:53:26.875556Z] Running setup-mitmproxy step. 08:53:26 INFO - Running pre-action listener: _resource_record_pre_action 08:53:26 INFO - Running main action method: setup_mitmproxy 08:53:26 INFO - Skipping: mitmproxy is not required 08:53:26 INFO - Running post-action listener: _resource_record_post_action 08:53:26 INFO - [mozharness: 2017-07-26 15:53:26.876696Z] Finished setup-mitmproxy step (success) 08:53:26 INFO - [mozharness: 2017-07-26 15:53:26.876921Z] Running run-tests step. 08:53:26 INFO - Running pre-action listener: _resource_record_pre_action 08:53:26 INFO - Running pre-action listener: _set_gcov_prefix 08:53:26 INFO - Running main action method: run_tests 08:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:26 INFO - Python 2.7.3 08:53:26 INFO - Return code: 0 08:53:26 INFO - grabbing minidump binary from tooltool 08:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:26 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/linux64/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 0x261ceb0>, '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 0x261ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x261e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:26 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:53:26 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/linux64/releng.manifest -o -c /builds/tooltool_cache 08:53:26 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:53:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:27 INFO - Return code: 0 08:53:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:53:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:27 INFO - ENV: RUST_BACKTRACE is now 1 08:53:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:53:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:53:27 INFO - Using env: {'DISPLAY': ':0', 08:53:27 INFO - 'HOME': '/home/cltbld', 08:53:27 INFO - 'LANG': 'en_US.UTF-8', 08:53:27 INFO - 'LANGUAGE': 'en_US:en', 08:53:27 INFO - 'LOGNAME': 'cltbld', 08:53:27 INFO - 'MAIL': '/var/mail/cltbld', 08:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:27 INFO - 'MOZ_NO_REMOTE': '1', 08:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:27 INFO - 'NO_EM_RESTART': '1', 08:53:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:27 INFO - 'PWD': '/builds/slave/test', 08:53:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:27 INFO - 'RUST_BACKTRACE': '1', 08:53:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:53:27 INFO - 'SHELL': '/bin/bash', 08:53:27 INFO - 'SHLVL': '1', 08:53:27 INFO - 'STYLO_FORCE_ENABLED': '1', 08:53:27 INFO - 'TERM': 'linux', 08:53:27 INFO - 'TMOUT': '86400', 08:53:27 INFO - 'USER': 'cltbld', 08:53:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892', 08:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:27 INFO - '_': '/tools/buildbot/bin/python'} 08:53:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:53:27 INFO - mozversion application_buildid: 20170726150338 08:53:27 INFO - mozversion application_changeset: 388d81ed93fa640f91d155f36254667c734157cf 08:53:27 INFO - mozversion application_display_name: Nightly 08:53:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:27 INFO - mozversion application_name: Firefox 08:53:27 INFO - mozversion application_remotingname: firefox 08:53:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:53:27 INFO - mozversion application_vendor: Mozilla 08:53:27 INFO - mozversion application_version: 56.0a1 08:53:27 INFO - mozversion platform_buildid: 20170726150338 08:53:27 INFO - mozversion platform_changeset: 388d81ed93fa640f91d155f36254667c734157cf 08:53:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:53:27 INFO - mozversion platform_version: 56.0a1 08:53:27 INFO - using testdate: 1501084407 08:53:27 INFO - actual date: 1501084407 08:53:27 INFO - starting webserver on 'localhost:44795' 08:53:27 INFO - SUITE-START | Running 2 tests 08:53:27 INFO - TEST-START | dromaeo_css 08:53:27 INFO - Initialising browser for dromaeo_css test... 08:53:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44795/getInfo.html -profile /tmp/tmpG0CVV0/profile 08:53:27 INFO - TEST-INFO | started process 8214 (/builds/slave/test/build/application/firefox/firefox http://localhost:44795/getInfo.html) 08:53:33 INFO - TEST-INFO | 8214: exit 0 08:53:33 INFO - Browser initialized. 08:53:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:53:33 INFO - TEST-INFO | started process 8444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG0CVV0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:34 INFO - PID 8444 | 08:53:34 INFO - PID 8444 | (/builds/slave/test/build/application/firefox/firefox:8499): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:53:34 INFO - PID 8444 | 08:53:44 INFO - PID 8444 | RSS: Main: 172965888 08:53:44 INFO - PID 8444 | 08:56:43 INFO - PID 8444 | Cycle 1(1): loaded http://localhost:44795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44795/tests/dromaeo/cssquery-ext.html) 08:56:45 INFO - PID 8444 | RSS: Main: 174407680 08:56:45 INFO - PID 8444 | 08:59:47 INFO - PID 8444 | Cycle 1(1): loaded http://localhost:44795/tests/dromaeo/cssquery-ext.html (next: http://localhost:44795/tests/dromaeo/cssquery-jquery.html) 08:59:47 INFO - PID 8444 | RSS: Main: 172539904 08:59:47 INFO - PID 8444 | 09:02:49 INFO - PID 8444 | Cycle 1(1): loaded http://localhost:44795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44795/tests/dromaeo/cssquery-mootools.html) 09:02:50 INFO - PID 8444 | RSS: Main: 173998080 09:02:50 INFO - PID 8444 | 09:05:52 INFO - PID 8444 | Cycle 1(1): loaded http://localhost:44795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44795/tests/dromaeo/cssquery-prototype.html) 09:05:52 INFO - PID 8444 | RSS: Main: 172511232 09:05:52 INFO - PID 8444 | 09:08:56 INFO - PID 8444 | Cycle 1(1): loaded http://localhost:44795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44795/tests/dromaeo/cssquery-yui.html) 09:08:57 INFO - PID 8444 | RSS: Main: 172212224 09:08:57 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | Cycle 1(1): loaded http://localhost:44795/tests/dromaeo/cssquery-yui.html (next: http://localhost:44795/tests/dromaeo/cssquery-dojo.html) 09:11:59 INFO - PID 8444 | RSS: Main: 176218112 09:11:59 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | __start_tp_report 09:11:59 INFO - PID 8444 | _x_x_mozilla_page_load 09:11:59 INFO - PID 8444 | _x_x_mozilla_page_load_details 09:11:59 INFO - PID 8444 | |i|pagename|runs| 09:11:59 INFO - PID 8444 | |0;dojo.html;3059.7552195824323;3089.042396856973;3096.8761249550025;3102.627684677839;3144.3868445653106;5933.347331793505;6019.428154325337;6099.725512351949;6128.08078788182;6155.969220153904;5966.731497082631;6014.097885317194;6047.788327408542;6093.299270583884;6109.786157484477;5524.392316845144;5549.972250138764;5560.833175004736;5590.301212348457;5616.943830561703;5565.6104072714925;5628.26832511775;5631.63394379366;5644.520215781664;5660.632058916178;5608.803691870786;5666.773329066832;5667.178259152421;5683.602147849652;5701.71491425427;5586;5659.405762394951;5671.829845104674;5679.545636349082;5697.173909783059;5458.263134476834;5489.094299440588;5496.972515137439;5602.4957753802355;5614.831555053355;5823.621464604787;5882.647041177543;5957.761689532457;6006.639601623917;6055.091736239555;6408.166938298038;6458.451031662315;6493.70778314977;6499.122618446497;6501.0898474213645;6576.868462630769;6578.572392794501;6584.30864759203;6585.242697089848;6590.505712071614;6081.908771368433;6084.878302433971;6088.726007329681;6095.573309868311;6108.358622344635;6745.662716864137;6747.122874026443;6763;6765.424938880152;6770;6414.262359828586;6422.2293324800385;6422.550421470452;6433.453156481752;6467;6564.146660934048;6573.244076931214;6636.668166591651;6652.201735791639;6673.9666301668185;6428.100065990765;6490.545661803629;6515.804525864231;6551.181102362205;6623.768168114189;6600.60396376219;6604.900926486107;6623.536352455379;6628.5691430056895;6629.966850165815;5318.414974352818;5319.6808191508635;5324.201369794484;5334.546563542142;5344.305240318734;4546.931796023062;4606.815727370935;4613.284940834176;4628.051249493913;4652.046330502307;5661.830145095653;5724.685142317129;5748.45389687979;5755.59710820247;5791.449812267828;6504.38208370204;6601;6604.3725846044545;6664.233613134455;6699.531032827753;5619.8876022480135;5654.6889921054735;5667.319921609351;5708.914366284509;5721.542276617861;5535.446455354513;5732.570057245724;5796.913046304308;5810.5351571875;5821.09772985188;6349.428551430394;6381.1385462962835;6454.77408290717;6459.612423254526;6460.095586617877;6414.839629009312;6538.869222615616;6592.43964263043;6680;6702.597844129368;6323.873522529616;6357.046443033582;6361.61830290184;6375.5218358624215;6381.968090159519;6356.55504114726;6424.903626445701;6461.838454038687;6470.99699546571;6489.5781774184525;6566.474682025331;6605.339466053356;6606.306337834458;6667.233268174222;6672.766453174116;6279.529035322278;6304.05439184126;6387.680615969276;6393.520485963479;6506.121673574007;6238.594491358047;6365.586236894587;6373.58571692857;6432.678366081771;6481.643509606828;6274.937250627435;6277.18396608438;6283.8114856554375;6284.3087260402235;6289;6362.840928976812;6397.8720425592155;6400.71196796136;6417;6450.612963222222;6169.444749972524;6217.564770466024;6220.03589443637;6234.688265586612;6235.127082208585 09:11:59 INFO - PID 8444 | |1;ext.html;767.129308235153;834.9206825351589;867.7049803066956;884.1556313720396;888.8133491966682;41917.161656766846;42750;42770;42823.57176428235;42825.35761963565;38909;38912.221755564875;39018.60981390185;39023.41464878022;39063.80468097656;6669.2330382006085;6809.250982391958;6818.9659051704675;6826.044353790473;6859.759908403207;6764.492663050266;6870.965645171792;6871;6873.931260687379;6876.346747059047;6844.4182244509275;7458;7653;7658.157602663702;7694.076710794685;7548.547087174759;7595.5442673439775;7613.390928725688;7616.847663046736;7617.923820761777;7366.889496657554;7494;7542.35889949355;7551.886721699179;7575.507592006502;38143.427848582294;38338;38538.80730596329;38575.228495430216;38682.80658596689;3535.222251104753;3581.803000834953;3583.910402239939;3583.9785661086466;3593.6765691087667;30341.089767307018;30397.392052158833;30460.69539304623;30473.085807425814;30519.542206866914;4840.419149702023;4863.659543831933;4877.707337559757;4900.926486102711;4974.42794078682;186246;186331.06834465876;188745;191915;192108;49238.50761492411;49834;49938.250926236135;49941.500584993686;50132;52563.73718131462;52639.473605264226;52697.2095418569;52736.47263527392;52841.207381889304;14994.550163494894;15105.47130850415;15139.924300378427;15167.165805880562;15298.464553740789;12343.629691109281;12397.814032789516;12406.441710123067;12407.44166512509;12419.31693756834;14373.568792936228;14524.346404411826;14624.853751462562;14649.681528662471;14724.852751472563;5686.2039314496005;5689.459501347365;5699.259096317535;5711.457411545896;5814.854628634318;988.7231575158823;997.1574019953129;1003.1322905686528;1021.2034613001871;1024.8872624011353;22187.445313867283;22238.444038899157;22348.217812376814;23235.76764232336;23369.649455258186;1074.897884700952;1088.3469918049266;1118.3848883114254;1122.3714719756963;1127.3855748617023;11869.406529673483;11959.701007474883;12298.20061695987;12309.630711078682;12371.381430928417;236261;236760;237672;238549;238586;52326.73836630792;52513.47486525162;52956.73521632367;53056.204156937674;53454;1446.1106419552111;1458.7520121579569;1492.0003597589641;1510.3052595805832;1522.117172040214;21681.241156559445;22019.54918012376;22425.439364015376;23317;23432.81131033258;36336;37270;37364;37690.811545942095;37700.43449348317;197279;197625;198013;199302;199366;30702.385952281275;31482.37035259328;31505;31518.842405787826;33979.66020339765;38754;39115.804420977714;43418.34872476852;43697.78151109224;44393.55606443894;30053.69946300509;31314.686853132087;32620.510692339158;32866.83566582152;33521;31927.840360798047;32123.196920077185;32304.676953230166;32352.191195220308;32935.835320823244;35665.28669426545;35731.285374291845;35870;35984.8200759005;36031.73888913875;29185.270368240963;29652;30451.847740761154;31255.374892502477;31779.841100794347;22328.330150095524;23551.764482355644;23728.881355593112;24691.87654061718;25833.612495812955 09:11:59 INFO - PID 8444 | |2;jquery.html;554.8501904485789;560.422764552511;568.2413977340249;570.614834986384;589.961652492588;21936.232231871887;22752.54494910103;22850.657240141412;22884.77115228847;23696.289111326645;25202.62196067056;25499.745002549967;25563.488730225385;25617.74382256177;25715.74284257157;6250.9062364064575;6452.451541618944;6454.612723236597;6457.935420645804;6461.838454038663;5754.136879468092;6302;6383.872322553546;6398.392152745481;6400.807975760735;6336.42972132508;6341.921873281553;6344.397282258178;6364.777232796853;6374.776882809103;6264.498840092827;6295.496360291166;6327.525435592349;6335.303116657187;6337.334579869116;5846.3861294563885;5854.648721076706;5864.413558644144;5866.560007999375;5886.264216972879;27958.440831183263;29055.98304059369;29536.556951645744;29718.851405743048;29849.10452686423;1909.5894382707784;1955.4133759872125;1965.9803401966083;1971.7831038585743;1973.5756812285283;18445.07774611264;19107.522311942175;19129.90435047816;19134.71297930532;19190.904045479823;2337.123578658003;2362.4684445999515;2391.186996421225;2399.748026457232;2415.0339864054345;133726;139984.30007849896;140000;140317;140653;14691.338889749986;15144.621384465256;15240.618984525476;15268.923655381652;15591.61020974462;23808;23947.760522394554;24003.399915002265;24074.39814004664;24108.87945560296;9826.16477599412;9927.056929591678;10069.144122749649;10075.244356673278;10093.798124037625;7914.841703165905;9074.818503630022;9164.725058248263;9225.354225204172;9245.352825302165;7711.768646940601;8831.161039701217;9317.695522626838;9354.345195836226;9429.811403771886;2809.395979864339;2813.127930341601;2848.8860445581945;2859.785516086302;2880.2079428157003;946.679796039737;952.1906379577442;961.1061712607342;985.2856678907734;990.1089019882164;19463.416097517096;19525;19613.90193049054;19772.218630327632;20570.79429205689;991.1129539062499;1029.9382037077798;1036.290141253244;1048.486241741541;1052.663147792699;10340.689779306633;10504.159667226604;10778.29941053829;11266.330358297775;11297;490621;498743;502948;507382;508841;122764.38617806854;124778.37610811887;126951;127787;129032;1231.6736064942797;1240.460399726104;1276.1449828614666;1284.4669462173094;1286.5304163980268;16583.83416165823;16965.23656435488;17615.11522763263;17636.206370713604;17812.643747125243;54049.72975135099;54817;54996.17505737337;57449;58433.70783146227;70255.64872175606;70418.29581704322;75944;81022.59488702519;81478;12483.750324993267;13165.802512962122;13174.07781455289;14643.19462429534;15212.391504340145;22805.88597057004;23508.177213797437;23530;24104.75895241025;24455.877720611996;18426.907865460587;18499.352522661644;19384.903075484533;19725.112369943676;19736.802631973496;16406.343746250015;16986.915065424593;17396.565085872953;17524;17818.287268509634;19524.9023754886;19725.802741972395;19866.304679336154;19879;19919.900400497903;14792.11247325164;14795;14853.108813471226;15052.924735376253;15073.849261507245;17760.3783867564;18620.44138675842;18743.969081700092;18781.53046173802;18990.905045474683 09:11:59 INFO - PID 8444 | |3;mootools.html;1360.8503064662887;1416.5254639695702;1418.9361478733456;1429.9571012869617;1432.3983926750766;13509.459621615137;13844.377003034862;13992.790108148372;14154.433822647095;14338.856611433883;14408.135511869295;14686.779698304506;14720.190389528572;14722.1166729996;14767.926160369183;2434.513097380522;2471.9258422247362;2492.140211626986;2493.9750602493923;2496.700395952488;2319.0491898321693;2319.130326127702;2370.075670488502;2371.9644205336936;2400.7239167495786;2395.4849707312924;2409.144753612469;2410.349205714456;2416.3838221253554;2457.5576396248666;2405.4707964247837;2414.2033129067368;2423.127674037354;2423.5031818477346;2428.1986944308424;2312.387217387394;2324.93025209244;2330.8484948478294;2338.38032921276;2344.296710986714;13617.455301787917;13826.23955682437;13827.585172444842;13877.167369957835;13914.860851391559;7281.563106213591;7553.962230188814;7556.357709594691;7561.24387561245;7575.09098908129;4884.19410797218;5037.319961805146;5133.8203162889495;5142.794288228466;5147.742612869379;1763.6649036682988;1828.1955939386628;1854.7866995295578;1884.1238823946794;1913.913873875679;21616.24343147998;22775.772242277697;22905.19831805879;23132.3060308191;23149;5995.280566332068;6082.482988945901;6167.167432396659;6208.379162083846;6298.212723409574;15562.844371556139;15640.608984775245;15794.210289485709;15802.841971580367;15807.841921580866;7058.6823592938445;7206.819829504199;7229.819254518679;7267.4549408794555;7301.598412087386;6615.272320044791;6675.6662166891465;6704.430123439464;6737.191537015589;6812.523123381415;4678.906421871544;4783.06730187617;4848.200046992207;4898.657094003457;4934.8766280843265;1332.826732524785;1334.426196735413;1337.779266421049;1340.7921772125337;1351.8580549042406;903.1194585279432;913.6025828764509;921.6037104045325;934.1732566678403;955.2978560757838;7008.719651213996;7323.707051717872;7520.6239688015385;7528.096628404626;7607.809804754926;691.3293317642209;710.8969199466152;726.2592156000956;742.5804420502399;747.6672880568095;4625.976870115628;4744.596709279681;4958.305837182797;5295.311609490742;5315.734213289397;19090.80909190918;19833.60332793336;19912.800871991094;19981.500462488555;19989.800101999084;19117.904410478135;19183.52041198981;19380.4185874424;19400.126994285292;19403.708944365844;8774.166454186841;9813.11681948628;10460.581576736997;10642.467876606139;10653.467326633638;7028.894566581607;8200.630971606412;8232.464889782144;8417.70538031166;8687.218150366498;15215.391384344503;15710.507501787311;15964.361425542847;16185.67628647444;16186.271617777464;15635.530934071996;16278.104704240906;16462;16566.420175293806;16670;12554.560590379293;13134.474621015435;13314.934805215753;13321.533746318832;13326.666833329244;12881.291528965998;13383.933080334536;13629.454821807016;13630.386632601358;13633.795493067413;10283.640072597424;10290.845637315597;10600.310979786289;10606.734831629272;10775.676729698122;9713.9028609713;10495.10791582724;10612.097971672185;10725.731856703645;10961.835572466578;9764.755881103029;9797.706068817946;9835.704928852147;9841.704748857546;9847.852282215916;7256.346928776436;7301.488895777457;7330.193678695233;7343.77968660941;7419.22098179705;7286.3442290192015;7322.707091716272;7385.48301618903;7490.925090749023;7503.212162722835 09:11:59 INFO - PID 8444 | |4;prototype.html;482.8213560982437;490.8233036107002;520.0638850069873;523.3275241314911;532.3611666000797;6111.480524155447;6126.203593532846;6156.860980718559;6175.629462232269;6184.165137706408;5857.912131318023;5952.404759524045;5997.88004239915;6041.214642096532;6063.87872242556;4780.354652121971;4781.187198176319;4822.204336284526;4866.245731911542;4902.166631672624;4836.637252206081;4866.732329721864;4886.218205087169;4907.380564413753;4941.357623508939;4688.906221875577;4751.624187906047;4753.500882407349;4794.760261986887;4825.686330388531;4848;4853.8543843684565;4888.633352498559;4893.266010098479;4936.481669424695;4332.696711230215;4352.542982986804;4393.868183954486;4398.362237475548;4414.247889294106;5864.325602555718;5876.3242227144;5894.204282421861;5921.881562368729;5978.491828194608;5622.313306008222;5652.34997975234;5654.519365853907;5657.3494048184575;5658.528782516534;6362.2683391409655;6365.395287447685;6403.007533832263;6412.262589802186;6425.389587989133;4789.233722604366;4794.400699912511;4822.9758851205515;4833.202521583969;4846.733429661367;6778.22050464198;6819.420349270318;6850.691718872663;6851.45188384928;6864.450843932474;4914.164592019365;4923.532264434873;4924.507549245047;4939.382577177853;4981.452040275567;4940.802367905244;4982.2811130160035;4987.12725273083;5008.69947803133;5018.322526458881;5562.471565201299;5574.637648552831;5624.521915637217;5624.91562626561;5626.409227031103;6267.247930248308;6415.326390728999;6420.903686444707;6450.387213214737;6455.289348322604;1628.1370873437097;1699.1674079700858;1703.3442124782048;1704.199026457563;1742.8692848036449;1142.7771584540935;1193.9880601193877;1210.0924306769923;1212.7574485103014;1215.428748488209;5550.417206193291;5580.079286917613;5621.831345059655;5649.802256920988;5674.460926212003;6511.772087976898;6542.672866356663;6548.8362790930605;6660.733570657119;6702.329767023356;5622.943770562242;5628.887422251532;5705.315362156568;5715.342735585377;5718.342390625131;3496.6852983231124;3499.3526197653514;3502.527158833576;3531.876384326536;3561.8753343632848;6442.131781783324;6487.578307410004;6488.772892948724;6511.804645860631;6528.183977002875;6776;6806.659667016629;6821.624810635363;6854.520183587101;6859.942017394861;6339.397757213057;6435.646039467781;6454.580452270588;6474.352564743488;6506.804795856132;6505.804825855232;6566.474682025331;6570.5400621956005;6631.6684165792485;6693.866122677422;6539.542232043711;6584.572002819801;6586.78144543261;6610.9669451652435;6612.900806488003;6350.904736428864;6373.904391434225;6394.136791533084;6419.743210271537;6472.385123413268;4893.363862697969;4918.458969513422;4928.310036594808;4957.182064959386;4972.453030166606;6561.835954100995;6582.539222254396;6642.070110184674;6691.46468282546;6693.564918280491;6401.679916004088;6417.743290268337;6447.129637498878;6493.350664933469;6508.967455162694;6155;6438.517111216771;6468.902966455601;6488.221413430419;6544;6056.545759068175;6229.626222426669;6266.342034086538;6282.403171698681;6347.619142851444;6328.114064031131;6356.841078973062;6358.491320694241;6476.481881449378;6491;6136.2943261523715;6143.6006659568775;6252.499800016079;6253.906191407042;6259.1550140730415 09:11:59 INFO - PID 8444 | |5;yui.html;923.4597760310219;935.4808081514761;945.5414124149781;946.4841661294594;953.7186529973657;18672.719909201373;19505.707414388795;19523.707144392847;19528;19542.413727588177;19766.604667906635;20845.06197221125;21587;21724.239651612195;21879.453013674665;1044.9529771160278;1064.9467526623675;1067.236925598197;1068.8984546468073;1070.1652710885521;976.7948730766548;1053.4995876958421;1057.820170571001;1060.204846365226;1060.697701155171;1105.6351404036689;1109.4397329348667;1109.9001089901908;1111.377628528027;1115.5928086248502;1093.6445655162065;1094.7591529863416;1099.0932480703452;1106.2311693373028;1108.3017698849712;798.2655956520016;804.4569915307203;805.87508936115;807.8061265296345;814.2020819596769;18773.71839422396;19826.504337391536;20059.097340619563;20124;20360.083796229206;20106.79893201064;20379.796202038087;20596.27913023052;20614.278500252418;20630.484237894023;15981.520554383387;16197.757033644504;16341.34634614614;16381.67236655272;16855.072970986592;3509.0700964244497;3516.7186625069935;3521.894343169709;3532.364174448598;3532.6643968822923;129746;130552.34723826415;131094.34452827674;134667;135178.3241083798;15384.30770615325;15646;15870.127143007245;16855.157242137844;17566.385176519016;30406.391872162432;30813.229669258;31138.844305778326;31176.376472470423;31380.529292060637;8734.825303493895;9230.815383692423;9245.768855778659;9248;9251.398659087272;4272.060146767706;4290.957090429056;4353.934690979574;4382.802773875183;4435.445569303837;4887.511248875084;5136.820211292662;5142.691438513626;5346;5780.797672081541;1060.9257351985286;1064.590132798878;1093.9617113400993;1098.780243951213;1099.1756182862853;558.4527163379829;648.9935100649028;670.3564578005072;672.2135101930655;689.5345641691838;11290.54837806495;12875.098743087894;13545.66135846592;13685.863141368658;14567.490137845336;652.4649787174566;659.9934000660028;693.8820400531922;699.1959246866043;709.1844378964232;5489.945100549024;5594.580406469531;5693.686847223443;5759.971200143972;5966.970165149147;99787.50106249568;102845;107151;108232.4588377053;108384;85939;91156.54421727848;91986;92178;92575.07424925665;71730.64134679294;71959.28040719735;77926.6103669478;78125.60937195277;78623;10675.929918081089;10992.676812538231;11183.161262905478;11566.421678915853;11569.421528923353;35351.29297414089;35963.64036359708;36552.08619784527;36736.63263367332;37927;44861;46253.30620040769;47108.05783884371;47387.289190661475;48820.75589622029;15941.760873587138;16233.837661623233;16302.510924672279;16406.917965410576;16663.75004374911;17557.912210438866;17824.10879455996;17846.553836153682;17932.372366967094;18066.1870215838;18691.813081869008;18785.34251301198;19278.807211927702;19485.220591176196;19647.901760491677;19174.712379314602;19377.4186774397;19897.204111835945;20097.59804803925;20186.39440816778;16748.916255418644;16750;16779.496615101565;16835.494935151964;17198.570035749206;13069.673258168621;13310.134841235289;13459.192448453125;13822.93088534551;13918.860811391756;12782.105252632227;13379.264140472367;13444.596662100153;13521.59435216945;14400 09:11:59 INFO - PID 8444 | __end_tp_report 09:11:59 INFO - PID 8444 | __start_cc_report 09:11:59 INFO - PID 8444 | _x_x_mozilla_cycle_collect,361 09:11:59 INFO - PID 8444 | __end_cc_report 09:11:59 INFO - PID 8444 | __startTimestamp1501085519592__endTimestamp 09:11:59 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | ------- Summary: start ------- 09:11:59 INFO - PID 8444 | Number of tests: 6 09:11:59 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | [#0] dojo.html Cycles:165 Average:6033.17 Median:6277.18 stddev:707.85 (11.3%) stddev-sans-first:670.49 09:11:59 INFO - PID 8444 | Values: 3059.8 3089.0 3096.9 3102.6 3144.4 5933.3 6019.4 6099.7 6128.1 6156.0 5966.7 6014.1 6047.8 6093.3 6109.8 5524.4 5550.0 5560.8 5590.3 5616.9 5565.6 5628.3 5631.6 5644.5 5660.6 5608.8 5666.8 5667.2 5683.6 5701.7 5586.0 5659.4 5671.8 5679.5 5697.2 5458.3 5489.1 5497.0 5602.5 5614.8 5823.6 5882.6 5957.8 6006.6 6055.1 6408.2 6458.5 6493.7 6499.1 6501.1 6576.9 6578.6 6584.3 6585.2 6590.5 6081.9 6084.9 6088.7 6095.6 6108.4 6745.7 6747.1 6763.0 6765.4 6770.0 6414.3 6422.2 6422.6 6433.5 6467.0 6564.1 6573.2 6636.7 6652.2 6674.0 6428.1 6490.5 6515.8 6551.2 6623.8 6600.6 6604.9 6623.5 6628.6 6630.0 5318.4 5319.7 5324.2 5334.5 5344.3 4546.9 4606.8 4613.3 4628.1 4652.0 5661.8 5724.7 5748.5 5755.6 5791.4 6504.4 6601.0 6604.4 6664.2 6699.5 5619.9 5654.7 5667.3 5708.9 5721.5 5535.4 5732.6 5796.9 5810.5 5821.1 6349.4 6381.1 6454.8 6459.6 6460.1 6414.8 6538.9 6592.4 6680.0 6702.6 6323.9 6357.0 6361.6 6375.5 6382.0 6356.6 6424.9 6461.8 6471.0 6489.6 6566.5 6605.3 6606.3 6667.2 6672.8 6279.5 6304.1 6387.7 6393.5 6506.1 6238.6 6365.6 6373.6 6432.7 6481.6 6274.9 6277.2 6283.8 6284.3 6289.0 6362.8 6397.9 6400.7 6417.0 6450.6 6169.4 6217.6 6220.0 6234.7 6235.1 09:11:59 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | [#1] ext.html Cycles:180 Average:37526.05 Median:19656.54 stddev:54352.51 (276.5%) stddev-sans-first:54434.90 09:11:59 INFO - PID 8444 | Values: 767.1 834.9 867.7 884.2 888.8 41917.2 42750.0 42770.0 42823.6 42825.4 38909.0 38912.2 39018.6 39023.4 39063.8 6669.2 6809.3 6819.0 6826.0 6859.8 6764.5 6871.0 6871.0 6873.9 6876.3 6844.4 7458.0 7653.0 7658.2 7694.1 7548.5 7595.5 7613.4 7616.8 7617.9 7366.9 7494.0 7542.4 7551.9 7575.5 38143.4 38338.0 38538.8 38575.2 38682.8 3535.2 3581.8 3583.9 3584.0 3593.7 30341.1 30397.4 30460.7 30473.1 30519.5 4840.4 4863.7 4877.7 4900.9 4974.4 186246.0 186331.1 188745.0 191915.0 192108.0 49238.5 49834.0 49938.3 49941.5 50132.0 52563.7 52639.5 52697.2 52736.5 52841.2 14994.6 15105.5 15139.9 15167.2 15298.5 12343.6 12397.8 12406.4 12407.4 12419.3 14373.6 14524.3 14624.9 14649.7 14724.9 5686.2 5689.5 5699.3 5711.5 5814.9 988.7 997.2 1003.1 1021.2 1024.9 22187.4 22238.4 22348.2 23235.8 23369.6 1074.9 1088.3 1118.4 1122.4 1127.4 11869.4 11959.7 12298.2 12309.6 12371.4 236261.0 236760.0 237672.0 238549.0 238586.0 52326.7 52513.5 52956.7 53056.2 53454.0 1446.1 1458.8 1492.0 1510.3 1522.1 21681.2 22019.5 22425.4 23317.0 23432.8 36336.0 37270.0 37364.0 37690.8 37700.4 197279.0 197625.0 198013.0 199302.0 199366.0 30702.4 31482.4 31505.0 31518.8 33979.7 38754.0 39115.8 43418.3 43697.8 44393.6 30053.7 31314.7 32620.5 32866.8 33521.0 31927.8 32123.2 32304.7 32352.2 32935.8 35665.3 35731.3 35870.0 35984.8 36031.7 29185.3 29652.0 30451.8 31255.4 31779.8 22328.3 23551.8 23728.9 24691.9 25833.6 09:11:59 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | [#2] jquery.html Cycles:180 Average:35541.68 Median:13029.38 stddev:84776.37 (650.7%) stddev-sans-first:84973.49 09:11:59 INFO - PID 8444 | Values: 554.9 560.4 568.2 570.6 590.0 21936.2 22752.5 22850.7 22884.8 23696.3 25202.6 25499.7 25563.5 25617.7 25715.7 6250.9 6452.5 6454.6 6457.9 6461.8 5754.1 6302.0 6383.9 6398.4 6400.8 6336.4 6341.9 6344.4 6364.8 6374.8 6264.5 6295.5 6327.5 6335.3 6337.3 5846.4 5854.6 5864.4 5866.6 5886.3 27958.4 29056.0 29536.6 29718.9 29849.1 1909.6 1955.4 1966.0 1971.8 1973.6 18445.1 19107.5 19129.9 19134.7 19190.9 2337.1 2362.5 2391.2 2399.7 2415.0 133726.0 139984.3 140000.0 140317.0 140653.0 14691.3 15144.6 15240.6 15268.9 15591.6 23808.0 23947.8 24003.4 24074.4 24108.9 9826.2 9927.1 10069.1 10075.2 10093.8 7914.8 9074.8 9164.7 9225.4 9245.4 7711.8 8831.2 9317.7 9354.3 9429.8 2809.4 2813.1 2848.9 2859.8 2880.2 946.7 952.2 961.1 985.3 990.1 19463.4 19525.0 19613.9 19772.2 20570.8 991.1 1029.9 1036.3 1048.5 1052.7 10340.7 10504.2 10778.3 11266.3 11297.0 490621.0 498743.0 502948.0 507382.0 508841.0 122764.4 124778.4 126951.0 127787.0 129032.0 1231.7 1240.5 1276.1 1284.5 1286.5 16583.8 16965.2 17615.1 17636.2 17812.6 54049.7 54817.0 54996.2 57449.0 58433.7 70255.6 70418.3 75944.0 81022.6 81478.0 12483.8 13165.8 13174.1 14643.2 15212.4 22805.9 23508.2 23530.0 24104.8 24455.9 18426.9 18499.4 19384.9 19725.1 19736.8 16406.3 16986.9 17396.6 17524.0 17818.3 19524.9 19725.8 19866.3 19879.0 19919.9 14792.1 14795.0 14853.1 15052.9 15073.8 17760.4 18620.4 18744.0 18781.5 18990.9 09:11:59 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | [#3] mootools.html Cycles:180 Average:8625.77 Median:2383.72 stddev:5958.96 (250.0%) stddev-sans-first:5950.67 09:11:59 INFO - PID 8444 | Values: 1360.9 1416.5 1418.9 1430.0 1432.4 13509.5 13844.4 13992.8 14154.4 14338.9 14408.1 14686.8 14720.2 14722.1 14767.9 2434.5 2471.9 2492.1 2494.0 2496.7 2319.0 2319.1 2370.1 2372.0 2400.7 2395.5 2409.1 2410.3 2416.4 2457.6 2405.5 2414.2 2423.1 2423.5 2428.2 2312.4 2324.9 2330.8 2338.4 2344.3 13617.5 13826.2 13827.6 13877.2 13914.9 7281.6 7554.0 7556.4 7561.2 7575.1 4884.2 5037.3 5133.8 5142.8 5147.7 1763.7 1828.2 1854.8 1884.1 1913.9 21616.2 22775.8 22905.2 23132.3 23149.0 5995.3 6082.5 6167.2 6208.4 6298.2 15562.8 15640.6 15794.2 15802.8 15807.8 7058.7 7206.8 7229.8 7267.5 7301.6 6615.3 6675.7 6704.4 6737.2 6812.5 4678.9 4783.1 4848.2 4898.7 4934.9 1332.8 1334.4 1337.8 1340.8 1351.9 903.1 913.6 921.6 934.2 955.3 7008.7 7323.7 7520.6 7528.1 7607.8 691.3 710.9 726.3 742.6 747.7 4626.0 4744.6 4958.3 5295.3 5315.7 19090.8 19833.6 19912.8 19981.5 19989.8 19117.9 19183.5 19380.4 19400.1 19403.7 8774.2 9813.1 10460.6 10642.5 10653.5 7028.9 8200.6 8232.5 8417.7 8687.2 15215.4 15710.5 15964.4 16185.7 16186.3 15635.5 16278.1 16462.0 16566.4 16670.0 12554.6 13134.5 13314.9 13321.5 13326.7 12881.3 13383.9 13629.5 13630.4 13633.8 10283.6 10290.8 10600.3 10606.7 10775.7 9713.9 10495.1 10612.1 10725.7 10961.8 9764.8 9797.7 9835.7 9841.7 9847.9 7256.3 7301.5 7330.2 7343.8 7419.2 7286.3 7322.7 7385.5 7490.9 7503.2 09:11:59 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | [#4] prototype.html Cycles:180 Average:5412.22 Median:5965.45 stddev:1524.63 (25.6%) stddev-sans-first:1483.33 09:11:59 INFO - PID 8444 | Values: 482.8 490.8 520.1 523.3 532.4 6111.5 6126.2 6156.9 6175.6 6184.2 5857.9 5952.4 5997.9 6041.2 6063.9 4780.4 4781.2 4822.2 4866.2 4902.2 4836.6 4866.7 4886.2 4907.4 4941.4 4688.9 4751.6 4753.5 4794.8 4825.7 4848.0 4853.9 4888.6 4893.3 4936.5 4332.7 4352.5 4393.9 4398.4 4414.2 5864.3 5876.3 5894.2 5921.9 5978.5 5622.3 5652.3 5654.5 5657.3 5658.5 6362.3 6365.4 6403.0 6412.3 6425.4 4789.2 4794.4 4823.0 4833.2 4846.7 6778.2 6819.4 6850.7 6851.5 6864.5 4914.2 4923.5 4924.5 4939.4 4981.5 4940.8 4982.3 4987.1 5008.7 5018.3 5562.5 5574.6 5624.5 5624.9 5626.4 6267.2 6415.3 6420.9 6450.4 6455.3 1628.1 1699.2 1703.3 1704.2 1742.9 1142.8 1194.0 1210.1 1212.8 1215.4 5550.4 5580.1 5621.8 5649.8 5674.5 6511.8 6542.7 6548.8 6660.7 6702.3 5622.9 5628.9 5705.3 5715.3 5718.3 3496.7 3499.4 3502.5 3531.9 3561.9 6442.1 6487.6 6488.8 6511.8 6528.2 6776.0 6806.7 6821.6 6854.5 6859.9 6339.4 6435.6 6454.6 6474.4 6506.8 6505.8 6566.5 6570.5 6631.7 6693.9 6539.5 6584.6 6586.8 6611.0 6612.9 6350.9 6373.9 6394.1 6419.7 6472.4 4893.4 4918.5 4928.3 4957.2 4972.5 6561.8 6582.5 6642.1 6691.5 6693.6 6401.7 6417.7 6447.1 6493.4 6509.0 6155.0 6438.5 6468.9 6488.2 6544.0 6056.5 6229.6 6266.3 6282.4 6347.6 6328.1 6356.8 6358.5 6476.5 6491.0 6136.3 6143.6 6252.5 6253.9 6259.2 09:11:59 INFO - PID 8444 | 09:11:59 INFO - PID 8444 | [#5] yui.html Cycles:180 Average:22488.08 Median:19707.25 stddev:30591.62 (155.2%) stddev-sans-first:30634.58 09:11:59 INFO - PID 8444 | Values: 923.5 935.5 945.5 946.5 953.7 18672.7 19505.7 19523.7 19528.0 19542.4 19766.6 20845.1 21587.0 21724.2 21879.5 1045.0 1064.9 1067.2 1068.9 1070.2 976.8 1053.5 1057.8 1060.2 1060.7 1105.6 1109.4 1109.9 1111.4 1115.6 1093.6 1094.8 1099.1 1106.2 1108.3 798.3 804.5 805.9 807.8 814.2 18773.7 19826.5 20059.1 20124.0 20360.1 20106.8 20379.8 20596.3 20614.3 20630.5 15981.5 16197.8 16341.3 16381.7 16855.1 3509.1 3516.7 3521.9 3532.4 3532.7 129746.0 130552.3 131094.3 134667.0 135178.3 15384.3 15646.0 15870.1 16855.2 17566.4 30406.4 30813.2 31138.8 31176.4 31380.5 8734.8 9230.8 9245.8 9248.0 9251.4 4272.1 4291.0 4353.9 4382.8 4435.4 4887.5 5136.8 5142.7 5346.0 5780.8 1060.9 1064.6 1094.0 1098.8 1099.2 558.5 649.0 670.4 672.2 689.5 11290.5 12875.1 13545.7 13685.9 14567.5 652.5 660.0 693.9 699.2 709.2 5489.9 5594.6 5693.7 5760.0 5967.0 99787.5 102845.0 107151.0 108232.5 108384.0 85939.0 91156.5 91986.0 92178.0 92575.1 71730.6 71959.3 77926.6 78125.6 78623.0 10675.9 10992.7 11183.2 11566.4 11569.4 35351.3 35963.6 36552.1 36736.6 37927.0 44861.0 46253.3 47108.1 47387.3 48820.8 15941.8 16233.8 16302.5 16406.9 16663.8 17557.9 17824.1 17846.6 17932.4 18066.2 18691.8 18785.3 19278.8 19485.2 19647.9 19174.7 19377.4 19897.2 20097.6 20186.4 16748.9 16750.0 16779.5 16835.5 17198.6 13069.7 13310.1 13459.2 13822.9 13918.9 12782.1 13379.3 13444.6 13521.6 14400.0 09:11:59 INFO - PID 8444 | -------- Summary: end -------- 09:11:59 INFO - PID 8444 | 09:12:00 INFO - TEST-INFO | 8444: exit 0 09:12:00 INFO - TEST-OK | dromaeo_css | took 1113042ms 09:12:00 INFO - TEST-START | kraken 09:12:00 INFO - Initialising browser for kraken test... 09:12:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44795/getInfo.html -profile /tmp/tmpp8_guv/profile 09:12:00 INFO - TEST-INFO | started process 8818 (/builds/slave/test/build/application/firefox/firefox http://localhost:44795/getInfo.html) 09:12:05 INFO - TEST-INFO | 8818: exit 0 09:12:05 INFO - Browser initialized. 09:12:05 INFO - Running cycle 1/1 for kraken test... 09:12:05 INFO - TEST-INFO | started process 9047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8_guv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:06 INFO - PID 9047 | 09:12:06 INFO - PID 9047 | (/builds/slave/test/build/application/firefox/firefox:9102): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:12:06 INFO - PID 9047 | 09:12:17 INFO - PID 9047 | RSS: Main: 172781568 09:12:17 INFO - PID 9047 | 09:12:19 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44795/tests/kraken/driver.html?testName=audio-beat-detection) 09:12:20 INFO - PID 9047 | RSS: Main: 179662848 09:12:20 INFO - PID 9047 | 09:12:23 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44795/tests/kraken/driver.html?testName=audio-dft) 09:12:24 INFO - PID 9047 | RSS: Main: 179298304 09:12:24 INFO - PID 9047 | 09:12:27 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44795/tests/kraken/driver.html?testName=audio-fft) 09:12:27 INFO - PID 9047 | RSS: Main: 172761088 09:12:27 INFO - PID 9047 | 09:12:29 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44795/tests/kraken/driver.html?testName=audio-oscillator) 09:12:30 INFO - PID 9047 | RSS: Main: 173588480 09:12:30 INFO - PID 9047 | 09:12:32 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:12:33 INFO - PID 9047 | RSS: Main: 173707264 09:12:33 INFO - PID 9047 | 09:12:36 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44795/tests/kraken/driver.html?testName=imaging-darkroom) 09:12:36 INFO - PID 9047 | RSS: Main: 176726016 09:12:36 INFO - PID 9047 | 09:12:40 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44795/tests/kraken/driver.html?testName=imaging-desaturate) 09:12:41 INFO - PID 9047 | RSS: Main: 176869376 09:12:41 INFO - PID 9047 | 09:12:43 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44795/tests/kraken/driver.html?testName=json-parse-financial) 09:12:44 INFO - PID 9047 | RSS: Main: 177000448 09:12:44 INFO - PID 9047 | 09:12:46 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:12:46 INFO - PID 9047 | RSS: Main: 176832512 09:12:46 INFO - PID 9047 | 09:12:48 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44795/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:12:49 INFO - PID 9047 | RSS: Main: 174194688 09:12:49 INFO - PID 9047 | 09:12:51 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:52 INFO - PID 9047 | RSS: Main: 173834240 09:12:52 INFO - PID 9047 | 09:12:54 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:55 INFO - PID 9047 | RSS: Main: 174555136 09:12:55 INFO - PID 9047 | 09:12:58 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:59 INFO - PID 9047 | RSS: Main: 174190592 09:12:59 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | Cycle 1(1): loaded http://localhost:44795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44795/tests/kraken/driver.html?testName=ai-astar) 09:13:01 INFO - PID 9047 | RSS: Main: 175906816 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | __start_tp_report 09:13:01 INFO - PID 9047 | _x_x_mozilla_page_load 09:13:01 INFO - PID 9047 | _x_x_mozilla_page_load_details 09:13:01 INFO - PID 9047 | |i|pagename|runs| 09:13:01 INFO - PID 9047 | |0;ai-astar;97;108;100;110;110;109;111;100;109;109 09:13:01 INFO - PID 9047 | |1;audio-beat-detection;148;119;148;176;124;149;149;119;167;118 09:13:01 INFO - PID 9047 | |2;audio-dft;162;163;162;163;163;164;170;167;162;164 09:13:01 INFO - PID 9047 | |3;audio-fft;76;76;77;168;75;77;75;78;163;76 09:13:01 INFO - PID 9047 | |4;audio-oscillator;79;80;134;78;79;79;125;79;78;134 09:13:01 INFO - PID 9047 | |5;imaging-gaussian-blur;114;113;114;115;115;113;114;114;115;114 09:13:01 INFO - PID 9047 | |6;imaging-darkroom;150;151;151;152;153;152;152;151;152;153 09:13:01 INFO - PID 9047 | |7;imaging-desaturate;94;93;95;94;94;94;95;95;94;94 09:13:01 INFO - PID 9047 | |8;json-parse-financial;56;54;54;54;56;53;54;53;53;54 09:13:01 INFO - PID 9047 | |9;json-stringify-tinderbox;55;54;55;54;54;59;56;55;54;55 09:13:01 INFO - PID 9047 | |10;stanford-crypto-aes;79;76;79;80;77;81;77;78;78;77 09:13:01 INFO - PID 9047 | |11;stanford-crypto-ccm;130;141;125;146;129;125;125;132;130;179 09:13:01 INFO - PID 9047 | |12;stanford-crypto-pbkdf2;181;176;176;192;181;184;179;173;178;173 09:13:01 INFO - PID 9047 | |13;stanford-crypto-sha256-iterative;69;67;74;69;69;68;68;67;66;66 09:13:01 INFO - PID 9047 | __end_tp_report 09:13:01 INFO - PID 9047 | __start_cc_report 09:13:01 INFO - PID 9047 | _x_x_mozilla_cycle_collect,948 09:13:01 INFO - PID 9047 | __end_cc_report 09:13:01 INFO - PID 9047 | __startTimestamp1501085581250__endTimestamp 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | ------- Summary: start ------- 09:13:01 INFO - PID 9047 | Number of tests: 14 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#0] ai-astar Cycles:10 Average:106.30 Median:109.50 stddev:5.17 (4.7%) stddev-sans-first:4.24 09:13:01 INFO - PID 9047 | Values: 97.0 108.0 100.0 110.0 110.0 109.0 111.0 100.0 109.0 109.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:148.50 stddev:20.84 (14.0%) stddev-sans-first:21.98 09:13:01 INFO - PID 9047 | Values: 148.0 119.0 148.0 176.0 124.0 149.0 149.0 119.0 167.0 118.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.58 (1.6%) stddev-sans-first:2.64 09:13:01 INFO - PID 9047 | Values: 162.0 163.0 162.0 163.0 163.0 164.0 170.0 167.0 162.0 164.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:37.66 (49.6%) stddev-sans-first:39.37 09:13:01 INFO - PID 9047 | Values: 76.0 76.0 77.0 168.0 75.0 77.0 75.0 78.0 163.0 76.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:79.00 stddev:25.31 (32.0%) stddev-sans-first:26.22 09:13:01 INFO - PID 9047 | Values: 79.0 80.0 134.0 78.0 79.0 79.0 125.0 79.0 78.0 134.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 09:13:01 INFO - PID 9047 | Values: 114.0 113.0 114.0 115.0 115.0 113.0 114.0 114.0 115.0 114.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:0.95 (0.6%) stddev-sans-first:0.78 09:13:01 INFO - PID 9047 | Values: 150.0 151.0 151.0 152.0 153.0 152.0 152.0 151.0 152.0 153.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:13:01 INFO - PID 9047 | Values: 94.0 93.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:0.93 09:13:01 INFO - PID 9047 | Values: 56.0 54.0 54.0 54.0 56.0 53.0 54.0 53.0 53.0 54.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:1.52 (2.8%) stddev-sans-first:1.62 09:13:01 INFO - PID 9047 | Values: 55.0 54.0 55.0 54.0 54.0 59.0 56.0 55.0 54.0 55.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:1.55 (2.0%) stddev-sans-first:1.62 09:13:01 INFO - PID 9047 | Values: 79.0 76.0 79.0 80.0 77.0 81.0 77.0 78.0 78.0 77.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:131.00 stddev:16.58 (12.7%) stddev-sans-first:17.43 09:13:01 INFO - PID 9047 | Values: 130.0 141.0 125.0 146.0 129.0 125.0 125.0 132.0 130.0 179.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:180.00 stddev:5.70 (3.2%) stddev-sans-first:6.01 09:13:01 INFO - PID 9047 | Values: 181.0 176.0 176.0 192.0 181.0 184.0 179.0 173.0 178.0 173.0 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.31 (3.4%) stddev-sans-first:2.44 09:13:01 INFO - PID 9047 | Values: 69.0 67.0 74.0 69.0 69.0 68.0 68.0 67.0 66.0 66.0 09:13:01 INFO - PID 9047 | -------- Summary: end -------- 09:13:01 INFO - PID 9047 | 09:13:01 INFO - PID 9047 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:13:01 INFO - TEST-INFO | 9047: exit 0 09:13:01 INFO - TEST-OK | kraken | took 61583ms 09:13:01 INFO - SUITE-END | took 1174s 09:13:01 INFO - Completed test suite (00:19:34) 09:13:01 INFO - javascript benchmark 09:13:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8334.755103276515, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.7552195824323, 3089.042396856973, 3096.8761249550025, 3102.627684677839, 3144.3868445653106, 5933.347331793505, 6019.428154325337, 6099.725512351949, 6128.08078788182, 6155.969220153904, 5966.731497082631, 6014.097885317194, 6047.788327408542, 6093.299270583884, 6109.786157484477, 5524.392316845144, 5549.972250138764, 5560.833175004736, 5590.301212348457, 5616.943830561703, 5565.6104072714925, 5628.26832511775, 5631.63394379366, 5644.520215781664, 5660.632058916178, 5608.803691870786, 5666.773329066832, 5667.178259152421, 5683.602147849652, 5701.71491425427, 5586.0, 5659.405762394951, 5671.829845104674, 5679.545636349082, 5697.173909783059, 5458.263134476834, 5489.094299440588, 5496.972515137439, 5602.4957753802355, 5614.831555053355, 5823.621464604787, 5882.647041177543, 5957.761689532457, 6006.639601623917, 6055.091736239555, 6408.166938298038, 6458.451031662315, 6493.70778314977, 6499.122618446497, 6501.0898474213645, 6576.868462630769, 6578.572392794501, 6584.30864759203, 6585.242697089848, 6590.505712071614, 6081.908771368433, 6084.878302433971, 6088.726007329681, 6095.573309868311, 6108.358622344635, 6745.662716864137, 6747.122874026443, 6763.0, 6765.424938880152, 6770.0, 6414.262359828586, 6422.2293324800385, 6422.550421470452, 6433.453156481752, 6467.0, 6564.146660934048, 6573.244076931214, 6636.668166591651, 6652.201735791639, 6673.9666301668185, 6428.100065990765, 6490.545661803629, 6515.804525864231, 6551.181102362205, 6623.768168114189, 6600.60396376219, 6604.900926486107, 6623.536352455379, 6628.5691430056895, 6629.966850165815, 5318.414974352818, 5319.6808191508635, 5324.201369794484, 5334.546563542142, 5344.305240318734, 4546.931796023062, 4606.815727370935, 4613.284940834176, 4628.051249493913, 4652.046330502307, 5661.830145095653, 5724.685142317129, 5748.45389687979, 5755.59710820247, 5791.449812267828, 6504.38208370204, 6601.0, 6604.3725846044545, 6664.233613134455, 6699.531032827753, 5619.8876022480135, 5654.6889921054735, 5667.319921609351, 5708.914366284509, 5721.542276617861, 5535.446455354513, 5732.570057245724, 5796.913046304308, 5810.5351571875, 5821.09772985188, 6349.428551430394, 6381.1385462962835, 6454.77408290717, 6459.612423254526, 6460.095586617877, 6414.839629009312, 6538.869222615616, 6592.43964263043, 6680.0, 6702.597844129368, 6323.873522529616, 6357.046443033582, 6361.61830290184, 6375.5218358624215, 6381.968090159519, 6356.55504114726, 6424.903626445701, 6461.838454038687, 6470.99699546571, 6489.5781774184525, 6566.474682025331, 6605.339466053356, 6606.306337834458, 6667.233268174222, 6672.766453174116, 6279.529035322278, 6304.05439184126, 6387.680615969276, 6393.520485963479, 6506.121673574007, 6238.594491358047, 6365.586236894587, 6373.58571692857, 6432.678366081771, 6481.643509606828, 6274.937250627435, 6277.18396608438, 6283.8114856554375, 6284.3087260402235, 6289.0, 6362.840928976812, 6397.8720425592155, 6400.71196796136, 6417.0, 6450.612963222222, 6169.444749972524, 6217.564770466024, 6220.03589443637, 6234.688265586612, 6235.127082208585], "value": 5980.410867881011, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.129308235153, 834.9206825351589, 867.7049803066956, 884.1556313720396, 888.8133491966682, 41917.161656766846, 42750.0, 42770.0, 42823.57176428235, 42825.35761963565, 38909.0, 38912.221755564875, 39018.60981390185, 39023.41464878022, 39063.80468097656, 6669.2330382006085, 6809.250982391958, 6818.9659051704675, 6826.044353790473, 6859.759908403207, 6764.492663050266, 6870.965645171792, 6871.0, 6873.931260687379, 6876.346747059047, 6844.4182244509275, 7458.0, 7653.0, 7658.157602663702, 7694.076710794685, 7548.547087174759, 7595.5442673439775, 7613.390928725688, 7616.847663046736, 7617.923820761777, 7366.889496657554, 7494.0, 7542.35889949355, 7551.886721699179, 7575.507592006502, 38143.427848582294, 38338.0, 38538.80730596329, 38575.228495430216, 38682.80658596689, 3535.222251104753, 3581.803000834953, 3583.910402239939, 3583.9785661086466, 3593.6765691087667, 30341.089767307018, 30397.392052158833, 30460.69539304623, 30473.085807425814, 30519.542206866914, 4840.419149702023, 4863.659543831933, 4877.707337559757, 4900.926486102711, 4974.42794078682, 186246.0, 186331.06834465876, 188745.0, 191915.0, 192108.0, 49238.50761492411, 49834.0, 49938.250926236135, 49941.500584993686, 50132.0, 52563.73718131462, 52639.473605264226, 52697.2095418569, 52736.47263527392, 52841.207381889304, 14994.550163494894, 15105.47130850415, 15139.924300378427, 15167.165805880562, 15298.464553740789, 12343.629691109281, 12397.814032789516, 12406.441710123067, 12407.44166512509, 12419.31693756834, 14373.568792936228, 14524.346404411826, 14624.853751462562, 14649.681528662471, 14724.852751472563, 5686.2039314496005, 5689.459501347365, 5699.259096317535, 5711.457411545896, 5814.854628634318, 988.7231575158823, 997.1574019953129, 1003.1322905686528, 1021.2034613001871, 1024.8872624011353, 22187.445313867283, 22238.444038899157, 22348.217812376814, 23235.76764232336, 23369.649455258186, 1074.897884700952, 1088.3469918049266, 1118.3848883114254, 1122.3714719756963, 1127.3855748617023, 11869.406529673483, 11959.701007474883, 12298.20061695987, 12309.630711078682, 12371.381430928417, 236261.0, 236760.0, 237672.0, 238549.0, 238586.0, 52326.73836630792, 52513.47486525162, 52956.73521632367, 53056.204156937674, 53454.0, 1446.1106419552111, 1458.7520121579569, 1492.0003597589641, 1510.3052595805832, 1522.117172040214, 21681.241156559445, 22019.54918012376, 22425.439364015376, 23317.0, 23432.81131033258, 36336.0, 37270.0, 37364.0, 37690.811545942095, 37700.43449348317, 197279.0, 197625.0, 198013.0, 199302.0, 199366.0, 30702.385952281275, 31482.37035259328, 31505.0, 31518.842405787826, 33979.66020339765, 38754.0, 39115.804420977714, 43418.34872476852, 43697.78151109224, 44393.55606443894, 30053.69946300509, 31314.686853132087, 32620.510692339158, 32866.83566582152, 33521.0, 31927.840360798047, 32123.196920077185, 32304.676953230166, 32352.191195220308, 32935.835320823244, 35665.28669426545, 35731.285374291845, 35870.0, 35984.8200759005, 36031.73888913875, 29185.270368240963, 29652.0, 30451.847740761154, 31255.374892502477, 31779.841100794347, 22328.330150095524, 23551.764482355644, 23728.881355593112, 24691.87654061718, 25833.612495812955], "value": 16884.765385794464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8501904485789, 560.422764552511, 568.2413977340249, 570.614834986384, 589.961652492588, 21936.232231871887, 22752.54494910103, 22850.657240141412, 22884.77115228847, 23696.289111326645, 25202.62196067056, 25499.745002549967, 25563.488730225385, 25617.74382256177, 25715.74284257157, 6250.9062364064575, 6452.451541618944, 6454.612723236597, 6457.935420645804, 6461.838454038663, 5754.136879468092, 6302.0, 6383.872322553546, 6398.392152745481, 6400.807975760735, 6336.42972132508, 6341.921873281553, 6344.397282258178, 6364.777232796853, 6374.776882809103, 6264.498840092827, 6295.496360291166, 6327.525435592349, 6335.303116657187, 6337.334579869116, 5846.3861294563885, 5854.648721076706, 5864.413558644144, 5866.560007999375, 5886.264216972879, 27958.440831183263, 29055.98304059369, 29536.556951645744, 29718.851405743048, 29849.10452686423, 1909.5894382707784, 1955.4133759872125, 1965.9803401966083, 1971.7831038585743, 1973.5756812285283, 18445.07774611264, 19107.522311942175, 19129.90435047816, 19134.71297930532, 19190.904045479823, 2337.123578658003, 2362.4684445999515, 2391.186996421225, 2399.748026457232, 2415.0339864054345, 133726.0, 139984.30007849896, 140000.0, 140317.0, 140653.0, 14691.338889749986, 15144.621384465256, 15240.618984525476, 15268.923655381652, 15591.61020974462, 23808.0, 23947.760522394554, 24003.399915002265, 24074.39814004664, 24108.87945560296, 9826.16477599412, 9927.056929591678, 10069.144122749649, 10075.244356673278, 10093.798124037625, 7914.841703165905, 9074.818503630022, 9164.725058248263, 9225.354225204172, 9245.352825302165, 7711.768646940601, 8831.161039701217, 9317.695522626838, 9354.345195836226, 9429.811403771886, 2809.395979864339, 2813.127930341601, 2848.8860445581945, 2859.785516086302, 2880.2079428157003, 946.679796039737, 952.1906379577442, 961.1061712607342, 985.2856678907734, 990.1089019882164, 19463.416097517096, 19525.0, 19613.90193049054, 19772.218630327632, 20570.79429205689, 991.1129539062499, 1029.9382037077798, 1036.290141253244, 1048.486241741541, 1052.663147792699, 10340.689779306633, 10504.159667226604, 10778.29941053829, 11266.330358297775, 11297.0, 490621.0, 498743.0, 502948.0, 507382.0, 508841.0, 122764.38617806854, 124778.37610811887, 126951.0, 127787.0, 129032.0, 1231.6736064942797, 1240.460399726104, 1276.1449828614666, 1284.4669462173094, 1286.5304163980268, 16583.83416165823, 16965.23656435488, 17615.11522763263, 17636.206370713604, 17812.643747125243, 54049.72975135099, 54817.0, 54996.17505737337, 57449.0, 58433.70783146227, 70255.64872175606, 70418.29581704322, 75944.0, 81022.59488702519, 81478.0, 12483.750324993267, 13165.802512962122, 13174.07781455289, 14643.19462429534, 15212.391504340145, 22805.88597057004, 23508.177213797437, 23530.0, 24104.75895241025, 24455.877720611996, 18426.907865460587, 18499.352522661644, 19384.903075484533, 19725.112369943676, 19736.802631973496, 16406.343746250015, 16986.915065424593, 17396.565085872953, 17524.0, 17818.287268509634, 19524.9023754886, 19725.802741972395, 19866.304679336154, 19879.0, 19919.900400497903, 14792.11247325164, 14795.0, 14853.108813471226, 15052.924735376253, 15073.849261507245, 17760.3783867564, 18620.44138675842, 18743.969081700092, 18781.53046173802, 18990.905045474683], "value": 11990.426103512134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.8503064662887, 1416.5254639695702, 1418.9361478733456, 1429.9571012869617, 1432.3983926750766, 13509.459621615137, 13844.377003034862, 13992.790108148372, 14154.433822647095, 14338.856611433883, 14408.135511869295, 14686.779698304506, 14720.190389528572, 14722.1166729996, 14767.926160369183, 2434.513097380522, 2471.9258422247362, 2492.140211626986, 2493.9750602493923, 2496.700395952488, 2319.0491898321693, 2319.130326127702, 2370.075670488502, 2371.9644205336936, 2400.7239167495786, 2395.4849707312924, 2409.144753612469, 2410.349205714456, 2416.3838221253554, 2457.5576396248666, 2405.4707964247837, 2414.2033129067368, 2423.127674037354, 2423.5031818477346, 2428.1986944308424, 2312.387217387394, 2324.93025209244, 2330.8484948478294, 2338.38032921276, 2344.296710986714, 13617.455301787917, 13826.23955682437, 13827.585172444842, 13877.167369957835, 13914.860851391559, 7281.563106213591, 7553.962230188814, 7556.357709594691, 7561.24387561245, 7575.09098908129, 4884.19410797218, 5037.319961805146, 5133.8203162889495, 5142.794288228466, 5147.742612869379, 1763.6649036682988, 1828.1955939386628, 1854.7866995295578, 1884.1238823946794, 1913.913873875679, 21616.24343147998, 22775.772242277697, 22905.19831805879, 23132.3060308191, 23149.0, 5995.280566332068, 6082.482988945901, 6167.167432396659, 6208.379162083846, 6298.212723409574, 15562.844371556139, 15640.608984775245, 15794.210289485709, 15802.841971580367, 15807.841921580866, 7058.6823592938445, 7206.819829504199, 7229.819254518679, 7267.4549408794555, 7301.598412087386, 6615.272320044791, 6675.6662166891465, 6704.430123439464, 6737.191537015589, 6812.523123381415, 4678.906421871544, 4783.06730187617, 4848.200046992207, 4898.657094003457, 4934.8766280843265, 1332.826732524785, 1334.426196735413, 1337.779266421049, 1340.7921772125337, 1351.8580549042406, 903.1194585279432, 913.6025828764509, 921.6037104045325, 934.1732566678403, 955.2978560757838, 7008.719651213996, 7323.707051717872, 7520.6239688015385, 7528.096628404626, 7607.809804754926, 691.3293317642209, 710.8969199466152, 726.2592156000956, 742.5804420502399, 747.6672880568095, 4625.976870115628, 4744.596709279681, 4958.305837182797, 5295.311609490742, 5315.734213289397, 19090.80909190918, 19833.60332793336, 19912.800871991094, 19981.500462488555, 19989.800101999084, 19117.904410478135, 19183.52041198981, 19380.4185874424, 19400.126994285292, 19403.708944365844, 8774.166454186841, 9813.11681948628, 10460.581576736997, 10642.467876606139, 10653.467326633638, 7028.894566581607, 8200.630971606412, 8232.464889782144, 8417.70538031166, 8687.218150366498, 15215.391384344503, 15710.507501787311, 15964.361425542847, 16185.67628647444, 16186.271617777464, 15635.530934071996, 16278.104704240906, 16462.0, 16566.420175293806, 16670.0, 12554.560590379293, 13134.474621015435, 13314.934805215753, 13321.533746318832, 13326.666833329244, 12881.291528965998, 13383.933080334536, 13629.454821807016, 13630.386632601358, 13633.795493067413, 10283.640072597424, 10290.845637315597, 10600.310979786289, 10606.734831629272, 10775.676729698122, 9713.9028609713, 10495.10791582724, 10612.097971672185, 10725.731856703645, 10961.835572466578, 9764.755881103029, 9797.706068817946, 9835.704928852147, 9841.704748857546, 9847.852282215916, 7256.346928776436, 7301.488895777457, 7330.193678695233, 7343.77968660941, 7419.22098179705, 7286.3442290192015, 7322.707091716272, 7385.48301618903, 7490.925090749023, 7503.212162722835], "value": 6190.862641147908, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.8213560982437, 490.8233036107002, 520.0638850069873, 523.3275241314911, 532.3611666000797, 6111.480524155447, 6126.203593532846, 6156.860980718559, 6175.629462232269, 6184.165137706408, 5857.912131318023, 5952.404759524045, 5997.88004239915, 6041.214642096532, 6063.87872242556, 4780.354652121971, 4781.187198176319, 4822.204336284526, 4866.245731911542, 4902.166631672624, 4836.637252206081, 4866.732329721864, 4886.218205087169, 4907.380564413753, 4941.357623508939, 4688.906221875577, 4751.624187906047, 4753.500882407349, 4794.760261986887, 4825.686330388531, 4848.0, 4853.8543843684565, 4888.633352498559, 4893.266010098479, 4936.481669424695, 4332.696711230215, 4352.542982986804, 4393.868183954486, 4398.362237475548, 4414.247889294106, 5864.325602555718, 5876.3242227144, 5894.204282421861, 5921.881562368729, 5978.491828194608, 5622.313306008222, 5652.34997975234, 5654.519365853907, 5657.3494048184575, 5658.528782516534, 6362.2683391409655, 6365.395287447685, 6403.007533832263, 6412.262589802186, 6425.389587989133, 4789.233722604366, 4794.400699912511, 4822.9758851205515, 4833.202521583969, 4846.733429661367, 6778.22050464198, 6819.420349270318, 6850.691718872663, 6851.45188384928, 6864.450843932474, 4914.164592019365, 4923.532264434873, 4924.507549245047, 4939.382577177853, 4981.452040275567, 4940.802367905244, 4982.2811130160035, 4987.12725273083, 5008.69947803133, 5018.322526458881, 5562.471565201299, 5574.637648552831, 5624.521915637217, 5624.91562626561, 5626.409227031103, 6267.247930248308, 6415.326390728999, 6420.903686444707, 6450.387213214737, 6455.289348322604, 1628.1370873437097, 1699.1674079700858, 1703.3442124782048, 1704.199026457563, 1742.8692848036449, 1142.7771584540935, 1193.9880601193877, 1210.0924306769923, 1212.7574485103014, 1215.428748488209, 5550.417206193291, 5580.079286917613, 5621.831345059655, 5649.802256920988, 5674.460926212003, 6511.772087976898, 6542.672866356663, 6548.8362790930605, 6660.733570657119, 6702.329767023356, 5622.943770562242, 5628.887422251532, 5705.315362156568, 5715.342735585377, 5718.342390625131, 3496.6852983231124, 3499.3526197653514, 3502.527158833576, 3531.876384326536, 3561.8753343632848, 6442.131781783324, 6487.578307410004, 6488.772892948724, 6511.804645860631, 6528.183977002875, 6776.0, 6806.659667016629, 6821.624810635363, 6854.520183587101, 6859.942017394861, 6339.397757213057, 6435.646039467781, 6454.580452270588, 6474.352564743488, 6506.804795856132, 6505.804825855232, 6566.474682025331, 6570.5400621956005, 6631.6684165792485, 6693.866122677422, 6539.542232043711, 6584.572002819801, 6586.78144543261, 6610.9669451652435, 6612.900806488003, 6350.904736428864, 6373.904391434225, 6394.136791533084, 6419.743210271537, 6472.385123413268, 4893.363862697969, 4918.458969513422, 4928.310036594808, 4957.182064959386, 4972.453030166606, 6561.835954100995, 6582.539222254396, 6642.070110184674, 6691.46468282546, 6693.564918280491, 6401.679916004088, 6417.743290268337, 6447.129637498878, 6493.350664933469, 6508.967455162694, 6155.0, 6438.517111216771, 6468.902966455601, 6488.221413430419, 6544.0, 6056.545759068175, 6229.626222426669, 6266.342034086538, 6282.403171698681, 6347.619142851444, 6328.114064031131, 6356.841078973062, 6358.491320694241, 6476.481881449378, 6491.0, 6136.2943261523715, 6143.6006659568775, 6252.499800016079, 6253.906191407042, 6259.1550140730415], "value": 4963.868836706475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.4597760310219, 935.4808081514761, 945.5414124149781, 946.4841661294594, 953.7186529973657, 18672.719909201373, 19505.707414388795, 19523.707144392847, 19528.0, 19542.413727588177, 19766.604667906635, 20845.06197221125, 21587.0, 21724.239651612195, 21879.453013674665, 1044.9529771160278, 1064.9467526623675, 1067.236925598197, 1068.8984546468073, 1070.1652710885521, 976.7948730766548, 1053.4995876958421, 1057.820170571001, 1060.204846365226, 1060.697701155171, 1105.6351404036689, 1109.4397329348667, 1109.9001089901908, 1111.377628528027, 1115.5928086248502, 1093.6445655162065, 1094.7591529863416, 1099.0932480703452, 1106.2311693373028, 1108.3017698849712, 798.2655956520016, 804.4569915307203, 805.87508936115, 807.8061265296345, 814.2020819596769, 18773.71839422396, 19826.504337391536, 20059.097340619563, 20124.0, 20360.083796229206, 20106.79893201064, 20379.796202038087, 20596.27913023052, 20614.278500252418, 20630.484237894023, 15981.520554383387, 16197.757033644504, 16341.34634614614, 16381.67236655272, 16855.072970986592, 3509.0700964244497, 3516.7186625069935, 3521.894343169709, 3532.364174448598, 3532.6643968822923, 129746.0, 130552.34723826415, 131094.34452827674, 134667.0, 135178.3241083798, 15384.30770615325, 15646.0, 15870.127143007245, 16855.157242137844, 17566.385176519016, 30406.391872162432, 30813.229669258, 31138.844305778326, 31176.376472470423, 31380.529292060637, 8734.825303493895, 9230.815383692423, 9245.768855778659, 9248.0, 9251.398659087272, 4272.060146767706, 4290.957090429056, 4353.934690979574, 4382.802773875183, 4435.445569303837, 4887.511248875084, 5136.820211292662, 5142.691438513626, 5346.0, 5780.797672081541, 1060.9257351985286, 1064.590132798878, 1093.9617113400993, 1098.780243951213, 1099.1756182862853, 558.4527163379829, 648.9935100649028, 670.3564578005072, 672.2135101930655, 689.5345641691838, 11290.54837806495, 12875.098743087894, 13545.66135846592, 13685.863141368658, 14567.490137845336, 652.4649787174566, 659.9934000660028, 693.8820400531922, 699.1959246866043, 709.1844378964232, 5489.945100549024, 5594.580406469531, 5693.686847223443, 5759.971200143972, 5966.970165149147, 99787.50106249568, 102845.0, 107151.0, 108232.4588377053, 108384.0, 85939.0, 91156.54421727848, 91986.0, 92178.0, 92575.07424925665, 71730.64134679294, 71959.28040719735, 77926.6103669478, 78125.60937195277, 78623.0, 10675.929918081089, 10992.676812538231, 11183.161262905478, 11566.421678915853, 11569.421528923353, 35351.29297414089, 35963.64036359708, 36552.08619784527, 36736.63263367332, 37927.0, 44861.0, 46253.30620040769, 47108.05783884371, 47387.289190661475, 48820.75589622029, 15941.760873587138, 16233.837661623233, 16302.510924672279, 16406.917965410576, 16663.75004374911, 17557.912210438866, 17824.10879455996, 17846.553836153682, 17932.372366967094, 18066.1870215838, 18691.813081869008, 18785.34251301198, 19278.807211927702, 19485.220591176196, 19647.901760491677, 19174.712379314602, 19377.4186774397, 19897.204111835945, 20097.59804803925, 20186.39440816778, 16748.916255418644, 16750.0, 16779.496615101565, 16835.494935151964, 17198.570035749206, 13069.673258168621, 13310.134841235289, 13459.192448453125, 13822.93088534551, 13918.860811391756, 12782.105252632227, 13379.264140472367, 13444.596662100153, 13521.59435216945, 14400.0], "value": 9009.426884857943, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 100.0, 110.0, 110.0, 109.0, 111.0, 100.0, 109.0, 109.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 148.0, 176.0, 124.0, 149.0, 149.0, 119.0, 167.0, 118.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 163.0, 164.0, 170.0, 167.0, 162.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 168.0, 75.0, 77.0, 75.0, 78.0, 163.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 134.0, 78.0, 79.0, 79.0, 125.0, 79.0, 78.0, 134.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 115.0, 115.0, 113.0, 114.0, 114.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 152.0, 153.0, 152.0, 152.0, 151.0, 152.0, 153.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 56.0, 53.0, 54.0, 53.0, 53.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 54.0, 59.0, 56.0, 55.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 79.0, 80.0, 77.0, 81.0, 77.0, 78.0, 78.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 141.0, 125.0, 146.0, 129.0, 125.0, 125.0, 132.0, 130.0, 179.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 176.0, 176.0, 192.0, 181.0, 184.0, 179.0, 173.0, 178.0, 173.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 74.0, 69.0, 69.0, 68.0, 68.0, 67.0, 66.0, 66.0], "value": 68.3, "unit": "score"}]}]} 09:13:01 INFO - Return code: 0 09:13:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:02 INFO - # TBPL SUCCESS # 09:13:02 INFO - Running post-action listener: _package_coverage_data 09:13:02 INFO - Running post-action listener: _resource_record_post_action 09:13:02 INFO - [mozharness: 2017-07-26 16:13:02.057368Z] Finished run-tests step (success) 09:13:02 INFO - Running post-run listener: _resource_record_post_run 09:13:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435441664; Read time: 16; Write time: 294184 09:13:02 INFO - TinderboxPrint: CPU usage
13.1% 09:13:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:13:02 INFO - TinderboxPrint: I/O write bytes / time
435,441,664 / 294,184 09:13:02 INFO - TinderboxPrint: CPU idle
8,259.7 (86.8%) 09:13:02 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 09:13:02 INFO - TinderboxPrint: Swap in / out
0 / 0 09:13:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107495424; Read time: 0; Write time: 85412 09:13:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:13:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 327946240; Read time: 0; Write time: 208772 09:13:02 INFO - Running post-run listener: _upload_blobber_files 09:13:02 INFO - Blob upload gear active. 09:13:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:13:03 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:04 INFO - (blobuploader) - INFO - Done attempting. 09:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:04 INFO - (blobuploader) - INFO - Done attempting. 09:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:08 INFO - (blobuploader) - INFO - Done attempting. 09:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:09 INFO - (blobuploader) - INFO - Done attempting. 09:13:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:09 INFO - Return code: 0 09:13:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2677a1fcd701eebdf6afaeef57e21815ea14c6b5afeac218263bebed64cf54ff3f4d7dd481fc24d94279fca83a7a2b5243a930a63e32623572e1c1defdcf39a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8eba13017cad3970ffd03b552483dc790b5c6cd5bdefffde0f9698ce515a35cc7b68f9d6d1d43b5c3b6ccccf7f7a41a7ea2a2ab622dfb05a6b0516cac62176", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b44f413c6aa8ac881ab7e49287eced4de1bf7c4042114065dfced0c6e0855056b4d933ad085283faff42c04bad511cbaa0ca3eefeca29d4b1aea950a3273a5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530089405a2639b71230361edd0be9fa7be97e2db577c8aedb47eba6e56b76863fb7df6c73aa5c73508681d9ccc687b70f16d1666b812f53582adfc93c78b68a"} 09:13:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:09 INFO - Contents: 09:13:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2677a1fcd701eebdf6afaeef57e21815ea14c6b5afeac218263bebed64cf54ff3f4d7dd481fc24d94279fca83a7a2b5243a930a63e32623572e1c1defdcf39a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8eba13017cad3970ffd03b552483dc790b5c6cd5bdefffde0f9698ce515a35cc7b68f9d6d1d43b5c3b6ccccf7f7a41a7ea2a2ab622dfb05a6b0516cac62176", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b44f413c6aa8ac881ab7e49287eced4de1bf7c4042114065dfced0c6e0855056b4d933ad085283faff42c04bad511cbaa0ca3eefeca29d4b1aea950a3273a5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530089405a2639b71230361edd0be9fa7be97e2db577c8aedb47eba6e56b76863fb7df6c73aa5c73508681d9ccc687b70f16d1666b812f53582adfc93c78b68a"} 09:13:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:09 INFO - Copying logs to upload dir... 09:13:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.397702 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-26 09:13:08.574237) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 09:13:08.580141) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2677a1fcd701eebdf6afaeef57e21815ea14c6b5afeac218263bebed64cf54ff3f4d7dd481fc24d94279fca83a7a2b5243a930a63e32623572e1c1defdcf39a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8eba13017cad3970ffd03b552483dc790b5c6cd5bdefffde0f9698ce515a35cc7b68f9d6d1d43b5c3b6ccccf7f7a41a7ea2a2ab622dfb05a6b0516cac62176", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b44f413c6aa8ac881ab7e49287eced4de1bf7c4042114065dfced0c6e0855056b4d933ad085283faff42c04bad511cbaa0ca3eefeca29d4b1aea950a3273a5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530089405a2639b71230361edd0be9fa7be97e2db577c8aedb47eba6e56b76863fb7df6c73aa5c73508681d9ccc687b70f16d1666b812f53582adfc93c78b68a"} build_url:https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/McIpE5nYSU6x4xohkK7ZTQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2677a1fcd701eebdf6afaeef57e21815ea14c6b5afeac218263bebed64cf54ff3f4d7dd481fc24d94279fca83a7a2b5243a930a63e32623572e1c1defdcf39a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8eba13017cad3970ffd03b552483dc790b5c6cd5bdefffde0f9698ce515a35cc7b68f9d6d1d43b5c3b6ccccf7f7a41a7ea2a2ab622dfb05a6b0516cac62176", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b44f413c6aa8ac881ab7e49287eced4de1bf7c4042114065dfced0c6e0855056b4d933ad085283faff42c04bad511cbaa0ca3eefeca29d4b1aea950a3273a5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530089405a2639b71230361edd0be9fa7be97e2db577c8aedb47eba6e56b76863fb7df6c73aa5c73508681d9ccc687b70f16d1666b812f53582adfc93c78b68a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 09:13:08.604417) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 09:13:08.606850) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1501081342.414593-1063394892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 09:13:08.687594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 09:13:08.689985) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 09:13:08.690304) ========= ========= Total master_lag: 0.20 =========