builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1501120149.3 results: success (0) revision: f1693d664f8e8ee4c79801630c181c28095cad56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.296825) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.297350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.297640) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.320068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.320353) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-26 18:49:09-- 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% 21.9M=0.001s 2017-07-26 18:49:09 (21.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.497763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.498113) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021436 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.551073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:09.554432) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f1693d664f8e8ee4c79801630c181c28095cad56 --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 f1693d664f8e8ee4c79801630c181c28095cad56 --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=88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-26 18:49:09,868 truncating revision to first 12 chars 2017-07-26 18:49:09,869 Setting DEBUG logging. 2017-07-26 18:49:09,869 attempt 1/10 2017-07-26 18:49:09,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f1693d664f8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-26 18:49:10,200 unpacking tar archive at: mozilla-central-f1693d664f8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:10.220175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:10.220498) ========= script_repo_revision: f1693d664f8e8ee4c79801630c181c28095cad56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:10.220927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:10.221213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-26 18:49:10.231276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-26 18:49:10.231690) ========= /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=88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:49:10 INFO - MultiFileLogger online at 20170726 18:49:10 in /builds/slave/test 18:49:10 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 18:49:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:49:10 INFO - {'append_to_log': False, 18:49:10 INFO - 'base_work_dir': '/builds/slave/test', 18:49:10 INFO - 'blob_upload_branch': 'Firefox', 18:49:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:49:10 INFO - 'branch': 'Firefox', 18:49:10 INFO - 'buildbot_json_path': 'buildprops.json', 18:49:10 INFO - 'code_coverage': False, 18:49:10 INFO - 'config_files': ('talos/linux_config.py',), 18:49:10 INFO - 'default_actions': ('clobber', 18:49:10 INFO - 'read-buildbot-config', 18:49:10 INFO - 'download-and-extract', 18:49:10 INFO - 'populate-webroot', 18:49:10 INFO - 'create-virtualenv', 18:49:10 INFO - 'install', 18:49:10 INFO - 'setup-mitmproxy', 18:49:10 INFO - 'run-tests'), 18:49:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:49:10 INFO - 'disable_ccov_upload': False, 18:49:10 INFO - 'download_minidump_stackwalk': True, 18:49:10 INFO - 'download_symbols': 'ondemand', 18:49:10 INFO - 'enable_stylo': False, 18:49:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:49:10 INFO - 'tooltool.py': '/tools/tooltool.py', 18:49:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:49:10 INFO - '/tools/misc-python/virtualenv.py')}, 18:49:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:49:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:49:10 INFO - 'gecko_profile': False, 18:49:10 INFO - 'gecko_profile_interval': 0, 18:49:10 INFO - 'installer_path': 'installer.exe', 18:49:10 INFO - 'log_level': 'info', 18:49:10 INFO - 'log_name': 'talos', 18:49:10 INFO - 'log_to_console': True, 18:49:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:49:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:49:10 INFO - 'opt_config_files': (), 18:49:10 INFO - 'pip_index': False, 18:49:10 INFO - 'suite': 'dromaeojs-e10s', 18:49:10 INFO - 'system_bits': '32', 18:49:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:49:10 INFO - 'title': 'talos-linux64-ix-044', 18:49:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:49:10 INFO - 'use_talos_json': True, 18:49:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:49:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:49:10 INFO - 'work_dir': 'build'} 18:49:10 INFO - [mozharness: 2017-07-27 01:49:10.656377Z] Running clobber step. 18:49:10 INFO - Running pre-action listener: _resource_record_pre_action 18:49:10 INFO - Running main action method: clobber 18:49:10 INFO - rmtree: /builds/slave/test/build 18:49:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:49:11 INFO - Running post-action listener: _resource_record_post_action 18:49:11 INFO - [mozharness: 2017-07-27 01:49:11.692691Z] Finished clobber step (success) 18:49:11 INFO - [mozharness: 2017-07-27 01:49:11.692793Z] Running read-buildbot-config step. 18:49:11 INFO - Running pre-action listener: _resource_record_pre_action 18:49:11 INFO - Running main action method: read_buildbot_config 18:49:11 INFO - Using buildbot properties: 18:49:11 INFO - { 18:49:11 INFO - "project": "", 18:49:11 INFO - "product": "firefox", 18:49:11 INFO - "who": "kwierso@gmail.com", 18:49:11 INFO - "installer_path": "public/build/target.tar.bz2", 18:49:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:49:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:49:11 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:49:11 INFO - "stage_platform": "linux64-stylosequential", 18:49:11 INFO - "basedir": "/builds/slave/test", 18:49:11 INFO - "buildnumber": 4, 18:49:11 INFO - "platform": "ubuntu64_hw_styloseq", 18:49:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:49:11 INFO - "slavebuilddir": "test", 18:49:11 INFO - "taskId": "eAS6H7PISeey9ROD5droyw", 18:49:11 INFO - "branch": "mozilla-central", 18:49:11 INFO - "script_repo_revision": "production", 18:49:11 INFO - "revision": "f1693d664f8e8ee4c79801630c181c28095cad56", 18:49:11 INFO - "slavename": "talos-linux64-ix-044", 18:49:11 INFO - "repo_path": "mozilla-central" 18:49:11 INFO - } 18:49:11 INFO - Finding installer, test and symbols from parent task. 18:49:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eAS6H7PISeey9ROD5droyw'}, attempt #1 18:49:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eAS6H7PISeey9ROD5droyw'}, attempt #1 18:49:12 INFO - Task dependencies: SoMb-NCNQqKm-PGrwDTeyQ 18:49:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ'}, attempt #1 18:49:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 18:49:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/test_packages.json 18:49:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.crashreporter-symbols.zip 18:49:13 INFO - Running post-action listener: _resource_record_post_action 18:49:13 INFO - [mozharness: 2017-07-27 01:49:13.038026Z] Finished read-buildbot-config step (success) 18:49:13 INFO - [mozharness: 2017-07-27 01:49:13.038247Z] Running download-and-extract step. 18:49:13 INFO - Running pre-action listener: _resource_record_pre_action 18:49:13 INFO - Running main action method: download_and_extract 18:49:13 INFO - mkdir: /builds/slave/test/build/tests 18:49:13 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')]} 18:49:13 INFO - trying https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.test_packages.json 18:49:13 INFO - Downloading https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:49:13 INFO - Downloaded 989 bytes. 18:49:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:49:13 INFO - Using the following test package requirements: 18:49:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:49:13 INFO - u'common': [u'target.common.tests.zip'], 18:49:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:49:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:49:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:49:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:49:13 INFO - u'mozbase': [u'target.common.tests.zip'], 18:49:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:49:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:49:13 INFO - u'web-platform': [u'target.common.tests.zip', 18:49:13 INFO - u'target.web-platform.tests.tar.gz'], 18:49:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:49:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:49:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip 18:49:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:49:13 INFO - Fetch https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip into memory 18:49:14 INFO - Content-Length response header: 72522739 18:49:14 INFO - Bytes received: 72522739 18:49:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:49:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip 18:49:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:49:26 INFO - Fetch https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.common.tests.zip into memory 18:49:27 INFO - Content-Length response header: 72522739 18:49:27 INFO - Bytes received: 72522739 18:49:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.talos.tests.zip 18:49:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:49:40 INFO - Fetch https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.talos.tests.zip into memory 18:49:41 INFO - Content-Length response header: 14496448 18:49:41 INFO - Bytes received: 14496448 18:49:41 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')]} 18:49:41 INFO - trying https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 18:49:41 INFO - Downloading https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:49:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:49:43 INFO - Downloaded 62197101 bytes. 18:49:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 18:49:43 INFO - mkdir: /builds/slave/test/properties 18:49:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:49:43 INFO - Writing to file /builds/slave/test/properties/build_url 18:49:43 INFO - Contents: 18:49:43 INFO - build_url:https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 18:49:43 INFO - Running post-action listener: _resource_record_post_action 18:49:43 INFO - Running post-action listener: set_extra_try_arguments 18:49:43 INFO - [mozharness: 2017-07-27 01:49:43.247833Z] Finished download-and-extract step (success) 18:49:43 INFO - [mozharness: 2017-07-27 01:49:43.247931Z] Running populate-webroot step. 18:49:43 INFO - Running pre-action listener: _resource_record_pre_action 18:49:43 INFO - Running main action method: populate_webroot 18:49:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:49:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:49:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:49:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:49:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:49:43 INFO - 'tests': ['damp', 'tps']}, 18:49:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:49:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:49:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:49:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:49:43 INFO - 'other-e10s': {'tests': ['a11yr', 18:49:43 INFO - 'ts_paint', 18:49:43 INFO - 'tpaint', 18:49:43 INFO - 'sessionrestore', 18:49:43 INFO - 'sessionrestore_many_windows', 18:49:43 INFO - 'sessionrestore_no_auto_restore', 18:49:43 INFO - 'tabpaint']}, 18:49:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:49:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:49:43 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:49:43 INFO - 'talos_options': ['--mitmproxy', 18:49:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:49:43 INFO - '--firstNonBlankPaint'], 18:49:43 INFO - 'tests': ['quantum_pageload_google', 18:49:43 INFO - 'quantum_pageload_youtube', 18:49:43 INFO - 'quantum_pageload_amazon', 18:49:43 INFO - 'quantum_pageload_facebook']}, 18:49:43 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:49:43 INFO - 'talos_options': ['--stylo', 18:49:43 INFO - '--mitmproxy', 18:49:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:49:43 INFO - '--firstNonBlankPaint'], 18:49:43 INFO - 'tests': ['quantum_pageload_google', 18:49:43 INFO - 'quantum_pageload_youtube', 18:49:43 INFO - 'quantum_pageload_amazon', 18:49:43 INFO - 'quantum_pageload_facebook']}, 18:49:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:49:43 INFO - 'tsvgr_opacity', 18:49:43 INFO - 'tart', 18:49:43 INFO - 'tscrollx', 18:49:43 INFO - 'cart', 18:49:43 INFO - 'tsvg_static']}, 18:49:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:49:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:49:43 INFO - 'talos_options': ['--xperf_path', 18:49:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:49:43 INFO - 'tests': ['tp5n']}}} 18:49:43 INFO - Running post-action listener: _resource_record_post_action 18:49:43 INFO - [mozharness: 2017-07-27 01:49:43.255339Z] Finished populate-webroot step (success) 18:49:43 INFO - [mozharness: 2017-07-27 01:49:43.255430Z] Running create-virtualenv step. 18:49:43 INFO - Running pre-action listener: _resource_record_pre_action 18:49:43 INFO - Running main action method: create_virtualenv 18:49:43 INFO - Creating virtualenv /builds/slave/test/build/venv 18:49:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:49:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:49:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:49:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:49:43 INFO - Using real prefix '/usr' 18:49:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:49:43 INFO - Installing distribute.............................................................................................................................................................................................done. 18:49:45 INFO - Installing pip.................done. 18:49:45 INFO - Return code: 0 18:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:49:46 INFO - Reading from file tmpfile_stdout 18:49:46 INFO - Output received: 18:49:46 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) 18:49:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:49:46 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')]} 18:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:46 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')]} 18:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:49:46 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 18:49:46 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 18:49:46 INFO - Using env: {'DISPLAY': ':0', 18:49:46 INFO - 'HOME': '/home/cltbld', 18:49:46 INFO - 'LANG': 'en_US.UTF-8', 18:49:46 INFO - 'LANGUAGE': 'en_US:en', 18:49:46 INFO - 'LOGNAME': 'cltbld', 18:49:46 INFO - 'MAIL': '/var/mail/cltbld', 18:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:46 INFO - 'MOZ_NO_REMOTE': '1', 18:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:46 INFO - 'NO_EM_RESTART': '1', 18:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:46 INFO - 'PWD': '/builds/slave/test', 18:49:46 INFO - 'SHELL': '/bin/bash', 18:49:46 INFO - 'SHLVL': '1', 18:49:46 INFO - 'TERM': 'linux', 18:49:46 INFO - 'TMOUT': '86400', 18:49:46 INFO - 'USER': 'cltbld', 18:49:46 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:46 INFO - '_': '/tools/buildbot/bin/python'} 18:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:46 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 18:49:46 INFO - Cleaning up... 18:49:46 INFO - Return code: 0 18:49:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:49:46 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')]} 18:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:46 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')]} 18:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:49:46 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 18:49:46 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 18:49:46 INFO - Using env: {'DISPLAY': ':0', 18:49:46 INFO - 'HOME': '/home/cltbld', 18:49:46 INFO - 'LANG': 'en_US.UTF-8', 18:49:46 INFO - 'LANGUAGE': 'en_US:en', 18:49:46 INFO - 'LOGNAME': 'cltbld', 18:49:46 INFO - 'MAIL': '/var/mail/cltbld', 18:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:46 INFO - 'MOZ_NO_REMOTE': '1', 18:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:46 INFO - 'NO_EM_RESTART': '1', 18:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:46 INFO - 'PWD': '/builds/slave/test', 18:49:46 INFO - 'SHELL': '/bin/bash', 18:49:46 INFO - 'SHLVL': '1', 18:49:46 INFO - 'TERM': 'linux', 18:49:46 INFO - 'TMOUT': '86400', 18:49:46 INFO - 'USER': 'cltbld', 18:49:46 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:46 INFO - '_': '/tools/buildbot/bin/python'} 18:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:46 INFO - Downloading/unpacking psutil>=3.1.1 18:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:49:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:49:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:49:47 INFO - Installing collected packages: psutil 18:49:47 INFO - Running setup.py install for psutil 18:49:47 INFO - building 'psutil._psutil_linux' extension 18:49:47 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 18:49:47 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 18:49:47 INFO - building 'psutil._psutil_posix' extension 18:49:47 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 18:49:48 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 18:49:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:49:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:49:48 INFO - Successfully installed psutil 18:49:48 INFO - Cleaning up... 18:49:48 INFO - Return code: 0 18:49:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:49:48 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')]} 18:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:48 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')]} 18:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:48 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:49:48 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 18:49:48 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 18:49:48 INFO - Using env: {'DISPLAY': ':0', 18:49:48 INFO - 'HOME': '/home/cltbld', 18:49:48 INFO - 'LANG': 'en_US.UTF-8', 18:49:48 INFO - 'LANGUAGE': 'en_US:en', 18:49:48 INFO - 'LOGNAME': 'cltbld', 18:49:48 INFO - 'MAIL': '/var/mail/cltbld', 18:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:48 INFO - 'MOZ_NO_REMOTE': '1', 18:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:48 INFO - 'NO_EM_RESTART': '1', 18:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:48 INFO - 'PWD': '/builds/slave/test', 18:49:48 INFO - 'SHELL': '/bin/bash', 18:49:48 INFO - 'SHLVL': '1', 18:49:48 INFO - 'TERM': 'linux', 18:49:48 INFO - 'TMOUT': '86400', 18:49:48 INFO - 'USER': 'cltbld', 18:49:48 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:48 INFO - '_': '/tools/buildbot/bin/python'} 18:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:49:48 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 18:49:48 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 18:49:48 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 18:49:48 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 18:49:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:49:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:49:49 INFO - Installing collected packages: mozsystemmonitor 18:49:49 INFO - Running setup.py install for mozsystemmonitor 18:49:49 INFO - Successfully installed mozsystemmonitor 18:49:49 INFO - Cleaning up... 18:49:49 INFO - Return code: 0 18:49:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:49:49 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')]} 18:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:49 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')]} 18:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:49:49 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 18:49:49 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 18:49:49 INFO - Using env: {'DISPLAY': ':0', 18:49:49 INFO - 'HOME': '/home/cltbld', 18:49:49 INFO - 'LANG': 'en_US.UTF-8', 18:49:49 INFO - 'LANGUAGE': 'en_US:en', 18:49:49 INFO - 'LOGNAME': 'cltbld', 18:49:49 INFO - 'MAIL': '/var/mail/cltbld', 18:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:49 INFO - 'MOZ_NO_REMOTE': '1', 18:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:49 INFO - 'NO_EM_RESTART': '1', 18:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:49 INFO - 'PWD': '/builds/slave/test', 18:49:49 INFO - 'SHELL': '/bin/bash', 18:49:49 INFO - 'SHLVL': '1', 18:49:49 INFO - 'TERM': 'linux', 18:49:49 INFO - 'TMOUT': '86400', 18:49:49 INFO - 'USER': 'cltbld', 18:49:49 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:49 INFO - '_': '/tools/buildbot/bin/python'} 18:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:49 INFO - Downloading/unpacking jsonschema==2.5.1 18:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:49:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:49:50 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 18:49:50 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 18:49:50 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 18:49:50 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 18:49:51 INFO - Downloading functools32-3.2.3-2.tar.gz 18:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:49:51 INFO - warning: no files found matching '*.txt' 18:49:51 INFO - no previously-included directories found matching 'build' 18:49:51 INFO - no previously-included directories found matching 'dist' 18:49:51 INFO - no previously-included directories found matching '.git*' 18:49:51 INFO - Installing collected packages: jsonschema, functools32 18:49:51 INFO - Running setup.py install for functools32 18:49:51 INFO - warning: no files found matching '*.txt' 18:49:51 INFO - no previously-included directories found matching 'build' 18:49:51 INFO - no previously-included directories found matching 'dist' 18:49:51 INFO - no previously-included directories found matching '.git*' 18:49:51 INFO - Successfully installed jsonschema functools32 18:49:51 INFO - Cleaning up... 18:49:51 INFO - Return code: 0 18:49:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:49: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')]} 18:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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')]} 18:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49: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', '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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:49: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:49: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 functools32==3.2.3-2 18:49:51 INFO - Using env: {'DISPLAY': ':0', 18:49:51 INFO - 'HOME': '/home/cltbld', 18:49:51 INFO - 'LANG': 'en_US.UTF-8', 18:49:51 INFO - 'LANGUAGE': 'en_US:en', 18:49:51 INFO - 'LOGNAME': 'cltbld', 18:49:51 INFO - 'MAIL': '/var/mail/cltbld', 18:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:51 INFO - 'MOZ_NO_REMOTE': '1', 18:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:51 INFO - 'NO_EM_RESTART': '1', 18:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:51 INFO - 'PWD': '/builds/slave/test', 18:49:51 INFO - 'SHELL': '/bin/bash', 18:49:51 INFO - 'SHLVL': '1', 18:49:51 INFO - 'TERM': 'linux', 18:49:51 INFO - 'TMOUT': '86400', 18:49:51 INFO - 'USER': 'cltbld', 18:49:51 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:51 INFO - '_': '/tools/buildbot/bin/python'} 18:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:49:51 INFO - Cleaning up... 18:49:51 INFO - Return code: 0 18:49:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:49: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')]} 18:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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')]} 18:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49: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', '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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:49: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 blobuploader==1.2.4 18:49:51 INFO - Using env: {'DISPLAY': ':0', 18:49:51 INFO - 'HOME': '/home/cltbld', 18:49:51 INFO - 'LANG': 'en_US.UTF-8', 18:49:51 INFO - 'LANGUAGE': 'en_US:en', 18:49:51 INFO - 'LOGNAME': 'cltbld', 18:49:51 INFO - 'MAIL': '/var/mail/cltbld', 18:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:51 INFO - 'MOZ_NO_REMOTE': '1', 18:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:51 INFO - 'NO_EM_RESTART': '1', 18:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:51 INFO - 'PWD': '/builds/slave/test', 18:49:51 INFO - 'SHELL': '/bin/bash', 18:49:51 INFO - 'SHLVL': '1', 18:49:51 INFO - 'TERM': 'linux', 18:49:51 INFO - 'TMOUT': '86400', 18:49:51 INFO - 'USER': 'cltbld', 18:49:51 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:51 INFO - '_': '/tools/buildbot/bin/python'} 18:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:51 INFO - Downloading/unpacking blobuploader==1.2.4 18:49: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 18:49: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 18:49: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 18:49: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 18:49:52 INFO - Downloading blobuploader-1.2.4.tar.gz 18:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:49:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:49:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:49: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 18:49: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 18:49: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 18:49: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 18:49:53 INFO - Downloading docopt-0.6.1.tar.gz 18:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:49:53 INFO - Installing collected packages: blobuploader, requests, docopt 18:49:53 INFO - Running setup.py install for blobuploader 18:49:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:49:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:49:53 INFO - Running setup.py install for requests 18:49:53 INFO - Running setup.py install for docopt 18:49:53 INFO - Successfully installed blobuploader requests docopt 18:49:53 INFO - Cleaning up... 18:49:54 INFO - Return code: 0 18:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:49: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')]} 18:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49: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')]} 18:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:54 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:49:54 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 18:49:54 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 18:49:54 INFO - Using env: {'DISPLAY': ':0', 18:49:54 INFO - 'HOME': '/home/cltbld', 18:49:54 INFO - 'LANG': 'en_US.UTF-8', 18:49:54 INFO - 'LANGUAGE': 'en_US:en', 18:49:54 INFO - 'LOGNAME': 'cltbld', 18:49:54 INFO - 'MAIL': '/var/mail/cltbld', 18:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:54 INFO - 'MOZ_NO_REMOTE': '1', 18:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:54 INFO - 'NO_EM_RESTART': '1', 18:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:54 INFO - 'PWD': '/builds/slave/test', 18:49:54 INFO - 'SHELL': '/bin/bash', 18:49:54 INFO - 'SHLVL': '1', 18:49:54 INFO - 'TERM': 'linux', 18:49:54 INFO - 'TMOUT': '86400', 18:49:54 INFO - 'USER': 'cltbld', 18:49:54 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:54 INFO - '_': '/tools/buildbot/bin/python'} 18:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:49:54 INFO - Running setup.py (path:/tmp/pip-46vdAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:49:54 INFO - Running setup.py (path:/tmp/pip-aw8FWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:49:54 INFO - Running setup.py (path:/tmp/pip-qOtbv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:49:54 INFO - Running setup.py (path:/tmp/pip-kO3Jdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:49:54 INFO - Running setup.py (path:/tmp/pip-KWw9fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:49:54 INFO - Running setup.py (path:/tmp/pip-9d_2H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:49:54 INFO - Running setup.py (path:/tmp/pip-gJuLaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:49:54 INFO - Running setup.py (path:/tmp/pip-9Fura4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:49:54 INFO - Running setup.py (path:/tmp/pip-BvUNtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:49:54 INFO - Running setup.py (path:/tmp/pip-iaMXkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:49:54 INFO - Running setup.py (path:/tmp/pip-AEraYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:49:55 INFO - Running setup.py (path:/tmp/pip-eoCJ49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:49:55 INFO - Running setup.py (path:/tmp/pip-3osEGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:49:55 INFO - Running setup.py (path:/tmp/pip-RqCJ7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:49:55 INFO - Running setup.py (path:/tmp/pip-DXM1PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:49:55 INFO - Running setup.py (path:/tmp/pip-4SuX1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:49:55 INFO - Running setup.py (path:/tmp/pip-3IHOP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:49:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:49:55 INFO - Running setup.py install for manifestparser 18:49:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:49:55 INFO - Running setup.py install for mozcrash 18:49:55 INFO - Running setup.py install for mozdebug 18:49:55 INFO - Running setup.py install for mozdevice 18:49:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:49:55 INFO - Running setup.py install for mozfile 18:49:55 INFO - Running setup.py install for mozhttpd 18:49:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Running setup.py install for mozinfo 18:49:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Running setup.py install for mozInstall 18:49:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Running setup.py install for mozleak 18:49:56 INFO - Running setup.py install for mozlog 18:49:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Running setup.py install for moznetwork 18:49:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Running setup.py install for mozprocess 18:49:56 INFO - Running setup.py install for mozprofile 18:49:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Running setup.py install for mozrunner 18:49:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:49:56 INFO - Running setup.py install for mozscreenshot 18:49:57 INFO - Running setup.py install for moztest 18:49:57 INFO - Running setup.py install for mozversion 18:49:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:49:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:49:57 INFO - Cleaning up... 18:49:57 INFO - Return code: 0 18:49:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:49:57 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')]} 18:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:57 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')]} 18:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:57 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:49:57 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 18:49:57 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 18:49:57 INFO - Using env: {'DISPLAY': ':0', 18:49:57 INFO - 'HOME': '/home/cltbld', 18:49:57 INFO - 'LANG': 'en_US.UTF-8', 18:49:57 INFO - 'LANGUAGE': 'en_US:en', 18:49:57 INFO - 'LOGNAME': 'cltbld', 18:49:57 INFO - 'MAIL': '/var/mail/cltbld', 18:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:57 INFO - 'MOZ_NO_REMOTE': '1', 18:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:57 INFO - 'NO_EM_RESTART': '1', 18:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:57 INFO - 'PWD': '/builds/slave/test', 18:49:57 INFO - 'SHELL': '/bin/bash', 18:49:57 INFO - 'SHLVL': '1', 18:49:57 INFO - 'TERM': 'linux', 18:49:57 INFO - 'TMOUT': '86400', 18:49:57 INFO - 'USER': 'cltbld', 18:49:57 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:57 INFO - '_': '/tools/buildbot/bin/python'} 18:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:49:57 INFO - Running setup.py (path:/tmp/pip-hcVrwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:49:57 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)) 18:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:49:57 INFO - Running setup.py (path:/tmp/pip-ibKsRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:49:57 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)) 18:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:49:57 INFO - Running setup.py (path:/tmp/pip-lG7P4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:49:57 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)) 18:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:49:57 INFO - Running setup.py (path:/tmp/pip-mNpUiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:49:57 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)) 18:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:49:57 INFO - Running setup.py (path:/tmp/pip-5geeZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:49:57 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)) 18:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:49:57 INFO - Running setup.py (path:/tmp/pip-wd1MJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:49:57 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)) 18:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:49:57 INFO - Running setup.py (path:/tmp/pip-sKOLjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:49:57 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)) 18:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:49:57 INFO - Running setup.py (path:/tmp/pip-2WiDk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:49:58 INFO - Running setup.py (path:/tmp/pip-bNClfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:49:58 INFO - Running setup.py (path:/tmp/pip-Sir02C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:49:58 INFO - Running setup.py (path:/tmp/pip-Pu6Arg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:49:58 INFO - Running setup.py (path:/tmp/pip-oSDZcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:49:58 INFO - Running setup.py (path:/tmp/pip-91BJQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:49:58 INFO - Running setup.py (path:/tmp/pip-X51x7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:49:58 INFO - Running setup.py (path:/tmp/pip-vGW8k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:49:58 INFO - Running setup.py (path:/tmp/pip-AxdU2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:49:58 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)) 18:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:49:58 INFO - Running setup.py (path:/tmp/pip-2363fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:49:58 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)) 18:49:58 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)) 18:49:58 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)) 18:49:58 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)) 18:49:58 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)) 18:49:58 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)) 18:49:58 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)) 18:49:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:49: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 18:49: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 18:49: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 18:49: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 18:49:59 INFO - Downloading blessings-1.6.tar.gz 18:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:49:59 INFO - Installing collected packages: blessings 18:49:59 INFO - Running setup.py install for blessings 18:49:59 INFO - Successfully installed blessings 18:49:59 INFO - Cleaning up... 18:50:00 INFO - Return code: 0 18:50:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:00 INFO - Reading from file tmpfile_stdout 18:50:00 INFO - Current package versions: 18:50:00 INFO - argparse == 1.2.1 18:50:00 INFO - blessings == 1.6 18:50:00 INFO - blobuploader == 1.2.4 18:50:00 INFO - docopt == 0.6.1 18:50:00 INFO - functools32 == 3.2.3-2 18:50:00 INFO - jsonschema == 2.5.1 18:50:00 INFO - manifestparser == 1.1 18:50:00 INFO - mozInstall == 1.13 18:50:00 INFO - mozcrash == 1.0 18:50:00 INFO - mozdebug == 0.1 18:50:00 INFO - mozdevice == 0.51 18:50:00 INFO - mozfile == 1.2 18:50:00 INFO - mozhttpd == 0.7 18:50:00 INFO - mozinfo == 0.10 18:50:00 INFO - mozleak == 0.1 18:50:00 INFO - mozlog == 3.5 18:50:00 INFO - moznetwork == 0.27 18:50:00 INFO - mozprocess == 0.25 18:50:00 INFO - mozprofile == 0.28 18:50:00 INFO - mozrunner == 6.13 18:50:00 INFO - mozscreenshot == 0.1 18:50:00 INFO - mozsystemmonitor == 0.3 18:50:00 INFO - moztest == 0.8 18:50:00 INFO - mozversion == 1.4 18:50:00 INFO - psutil == 3.1.1 18:50:00 INFO - requests == 1.2.3 18:50:00 INFO - wsgiref == 0.1.2 18:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:00 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')]} 18:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:00 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')]} 18:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:00 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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:50:00 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 18:50:00 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 18:50:00 INFO - Using env: {'DISPLAY': ':0', 18:50:00 INFO - 'HOME': '/home/cltbld', 18:50:00 INFO - 'LANG': 'en_US.UTF-8', 18:50:00 INFO - 'LANGUAGE': 'en_US:en', 18:50:00 INFO - 'LOGNAME': 'cltbld', 18:50:00 INFO - 'MAIL': '/var/mail/cltbld', 18:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:00 INFO - 'MOZ_NO_REMOTE': '1', 18:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:00 INFO - 'NO_EM_RESTART': '1', 18:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:00 INFO - 'PWD': '/builds/slave/test', 18:50:00 INFO - 'SHELL': '/bin/bash', 18:50:00 INFO - 'SHLVL': '1', 18:50:00 INFO - 'TERM': 'linux', 18:50:00 INFO - 'TMOUT': '86400', 18:50:00 INFO - 'USER': 'cltbld', 18:50:00 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:00 INFO - '_': '/tools/buildbot/bin/python'} 18:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:00 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)) 18:50:00 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)) 18:50:00 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)) 18:50:00 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)) 18:50:00 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)) 18:50:00 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)) 18:50:00 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)) 18:50:00 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)) 18:50:00 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)) 18:50:00 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:01 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:50:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:50:01 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)) 18:50:01 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)) 18:50:01 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)) 18:50:01 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)) 18:50:01 INFO - Installing collected packages: marionette-driver, simplejson 18:50:01 INFO - Running setup.py install for marionette-driver 18:50:01 INFO - Running setup.py install for simplejson 18:50:02 INFO - building 'simplejson._speedups' extension 18:50:02 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 18:50:02 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 18:50:02 INFO - Successfully installed marionette-driver simplejson 18:50:02 INFO - Cleaning up... 18:50:03 INFO - Return code: 0 18:50:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:50:03 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')]} 18:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:03 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')]} 18:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', '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 18:50:03 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 18:50:03 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 18:50:03 INFO - Using env: {'DISPLAY': ':0', 18:50:03 INFO - 'HOME': '/home/cltbld', 18:50:03 INFO - 'LANG': 'en_US.UTF-8', 18:50:03 INFO - 'LANGUAGE': 'en_US:en', 18:50:03 INFO - 'LOGNAME': 'cltbld', 18:50:03 INFO - 'MAIL': '/var/mail/cltbld', 18:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:03 INFO - 'MOZ_NO_REMOTE': '1', 18:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:03 INFO - 'NO_EM_RESTART': '1', 18:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:03 INFO - 'PWD': '/builds/slave/test', 18:50:03 INFO - 'SHELL': '/bin/bash', 18:50:03 INFO - 'SHLVL': '1', 18:50:03 INFO - 'TERM': 'linux', 18:50:03 INFO - 'TMOUT': '86400', 18:50:03 INFO - 'USER': 'cltbld', 18:50:03 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:03 INFO - '_': '/tools/buildbot/bin/python'} 18:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:50:03 INFO - Cleaning up... 18:50:03 INFO - Return code: 0 18:50:03 INFO - Running post-action listener: _resource_record_post_action 18:50:03 INFO - Running post-action listener: _start_resource_monitoring 18:50:03 INFO - Starting resource monitoring. 18:50:03 INFO - [mozharness: 2017-07-27 01:50:03.260319Z] Finished create-virtualenv step (success) 18:50:03 INFO - [mozharness: 2017-07-27 01:50:03.260824Z] Running install step. 18:50:03 INFO - Running pre-action listener: _resource_record_pre_action 18:50:03 INFO - Running main action method: install 18:50:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:03 INFO - Reading from file tmpfile_stdout 18:50:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:50:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:50:03 INFO - Reading from file tmpfile_stdout 18:50:03 INFO - Output received: 18:50:03 INFO - Usage: mozinstall [options] installer 18:50:03 INFO - Options: 18:50:03 INFO - -h, --help show this help message and exit 18:50:03 INFO - -d DEST, --destination=DEST 18:50:03 INFO - Directory to install application into. [default: 18:50:03 INFO - "/builds/slave/test"] 18:50:03 INFO - --app=APP Application being installed. [default: firefox] 18:50:03 INFO - mkdir: /builds/slave/test/build/application 18:50:03 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'] 18:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:50:21 INFO - Reading from file tmpfile_stdout 18:50:21 INFO - Output received: 18:50:21 INFO - /builds/slave/test/build/application/firefox/firefox 18:50:21 INFO - Running post-action listener: _resource_record_post_action 18:50:21 INFO - [mozharness: 2017-07-27 01:50:21.612962Z] Finished install step (success) 18:50:21 INFO - [mozharness: 2017-07-27 01:50:21.613215Z] Running setup-mitmproxy step. 18:50:21 INFO - Running pre-action listener: _resource_record_pre_action 18:50:21 INFO - Running main action method: setup_mitmproxy 18:50:21 INFO - Skipping: mitmproxy is not required 18:50:21 INFO - Running post-action listener: _resource_record_post_action 18:50:21 INFO - [mozharness: 2017-07-27 01:50:21.614410Z] Finished setup-mitmproxy step (success) 18:50:21 INFO - [mozharness: 2017-07-27 01:50:21.614632Z] Running run-tests step. 18:50:21 INFO - Running pre-action listener: _resource_record_pre_action 18:50:21 INFO - Running pre-action listener: _set_gcov_prefix 18:50:21 INFO - Running main action method: run_tests 18:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:50:21 INFO - Python 2.7.3 18:50:21 INFO - Return code: 0 18:50:21 INFO - grabbing minidump binary from tooltool 18:50:21 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')]} 18:50:21 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 0x1b7aeb0>, '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 0x1b7bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:50:21 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 18:50:21 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 18:50:21 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 18:50:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:50:21 INFO - Return code: 0 18:50:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:50:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:50:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:50:21 INFO - ENV: RUST_BACKTRACE is now 1 18:50:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:50:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:50:21 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/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 18:50:21 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/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 18:50:21 INFO - Using env: {'DISPLAY': ':0', 18:50:21 INFO - 'HOME': '/home/cltbld', 18:50:21 INFO - 'LANG': 'en_US.UTF-8', 18:50:21 INFO - 'LANGUAGE': 'en_US:en', 18:50:21 INFO - 'LOGNAME': 'cltbld', 18:50:21 INFO - 'MAIL': '/var/mail/cltbld', 18:50:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:50:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:21 INFO - 'MOZ_NO_REMOTE': '1', 18:50:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:21 INFO - 'NO_EM_RESTART': '1', 18:50:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:21 INFO - 'PWD': '/builds/slave/test', 18:50:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:50:21 INFO - 'RUST_BACKTRACE': '1', 18:50:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:50:21 INFO - 'SHELL': '/bin/bash', 18:50:21 INFO - 'SHLVL': '1', 18:50:21 INFO - 'STYLO_FORCE_ENABLED': '1', 18:50:21 INFO - 'TERM': 'linux', 18:50:21 INFO - 'TMOUT': '86400', 18:50:21 INFO - 'USER': 'cltbld', 18:50:21 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337', 18:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:21 INFO - '_': '/tools/buildbot/bin/python'} 18:50:21 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/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 18:50:21 INFO - mozversion application_buildid: 20170727010339 18:50:21 INFO - mozversion application_changeset: f1693d664f8e8ee4c79801630c181c28095cad56 18:50:21 INFO - mozversion application_display_name: Nightly 18:50:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:50:21 INFO - mozversion application_name: Firefox 18:50:21 INFO - mozversion application_remotingname: firefox 18:50:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:50:21 INFO - mozversion application_vendor: Mozilla 18:50:21 INFO - mozversion application_version: 56.0a1 18:50:21 INFO - mozversion platform_buildid: 20170727010339 18:50:21 INFO - mozversion platform_changeset: f1693d664f8e8ee4c79801630c181c28095cad56 18:50:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:50:21 INFO - mozversion platform_version: 56.0a1 18:50:21 INFO - using testdate: 1501120221 18:50:21 INFO - actual date: 1501120221 18:50:21 INFO - starting webserver on 'localhost:43401' 18:50:21 INFO - SUITE-START | Running 2 tests 18:50:21 INFO - TEST-START | dromaeo_css 18:50:21 INFO - Initialising browser for dromaeo_css test... 18:50:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html -profile /tmp/tmpCa6JKZ/profile 18:50:21 INFO - TEST-INFO | started process 4761 (/builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html) 18:50:27 INFO - TEST-INFO | 4761: exit 0 18:50:28 INFO - Browser initialized. 18:50:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:50:28 INFO - TEST-INFO | started process 4988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCa6JKZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:29 INFO - PID 4988 | 18:50:29 INFO - PID 4988 | (/builds/slave/test/build/application/firefox/firefox:5042): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:50:29 INFO - PID 4988 | 18:50:39 INFO - PID 4988 | RSS: Main: 172838912 18:50:39 INFO - PID 4988 | 18:53:38 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43401/tests/dromaeo/cssquery-ext.html) 18:53:40 INFO - PID 4988 | RSS: Main: 174264320 18:53:40 INFO - PID 4988 | 18:56:42 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-ext.html (next: http://localhost:43401/tests/dromaeo/cssquery-jquery.html) 18:56:42 INFO - PID 4988 | RSS: Main: 172265472 18:56:42 INFO - PID 4988 | 18:59:44 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43401/tests/dromaeo/cssquery-mootools.html) 18:59:45 INFO - PID 4988 | RSS: Main: 173993984 18:59:45 INFO - PID 4988 | 19:02:47 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43401/tests/dromaeo/cssquery-prototype.html) 19:02:47 INFO - PID 4988 | RSS: Main: 172580864 19:02:47 INFO - PID 4988 | 19:05:51 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43401/tests/dromaeo/cssquery-yui.html) 19:05:52 INFO - PID 4988 | RSS: Main: 174260224 19:05:52 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-yui.html (next: http://localhost:43401/tests/dromaeo/cssquery-dojo.html) 19:08:54 INFO - PID 4988 | RSS: Main: 176865280 19:08:54 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | __start_tp_report 19:08:54 INFO - PID 4988 | _x_x_mozilla_page_load 19:08:54 INFO - PID 4988 | _x_x_mozilla_page_load_details 19:08:54 INFO - PID 4988 | |i|pagename|runs| 19:08:54 INFO - PID 4988 | |0;dojo.html;3064.831434271114;3068.2636167319847;3072.907812765617;3105.5496952941826;3143.842807859608;6108;6125.663088530135;6130.724117414716;6131.233595800525;6164.445199932005;6198.318184999646;6245.875082498347;6246.843828904268;6274.278457977334;6274.372562743723;5613.80351687691;5674;5700.201971723962;5750.281214848144;5763.711814409284;5481.588880833953;5591.580631452657;5615.578831587647;5630.465105814941;5687.544996400299;5600.411956744544;5693.516051135658;5704.201411802351;5705.25831641886;5725.828225153252;5624.887502249973;5644.322681278273;5699.230603868507;5719.542436605103;5720.856978575527;5450.890982180374;5600.243967064435;5638;5646.887062258732;5680.233168522238;6022.6687532185715;6050.031994880798;6061.151438798572;6101.725422356005;6102.908456373158;6524.641144737037;6592.76925307612;6600.339966003409;6617.205935287748;6642.236142843538;6583.802485925382;6614.2393624733295;6678.43233325168;6715.966420167917;6750.021246919169;6052.878942421127;6148.538859585504;6152.323244443108;6239.469645080128;6263.530235232331;6693.966530167318;6713.765018224436;6725.2602213756445;6727.596344219362;6737.326267373223;6404.1674582304;6418.972964325685;6436.034594810816;6449.258335291408;6533.085368048477;6578.506612004119;6593.3736295051895;6598.802035938929;6601.174853143357;6602.7028783704845;6586.8353291168105;6601.240857301375;6607.702653380513;6614.801555953329;6627.304133066055;6535.607863528204;6546.247181574085;6550.0829883816305;6650.933490665128;6654.933450665529;5220.1647736362;5298.682079075268;5307.65500242483;5360.973195133999;5375.086235340002;4557.680962332671;4563.703359281636;4579.9084018319445;4584.633229341644;4591.265397536378;5700.315962084494;5703.030484817591;5703.230063941398;5707.914381284284;5716.314042314949;6670.899936500957;6697.129373181455;6704.396604305636;6711.429528490035;6719.596824190564;5598.720063996784;5620.100783874561;5688.715564221772;5694;5701.572382071361;5719.656820590778;5760.337561180518;5781.5952883298605;5817.38917413674;5868.911966320508;6460.966245400713;6469.708863101077;6478.838029049311;6480.092787009822;6483.675816209171;6589.736410543716;6692.263850976486;6702.631355275506;6702.698378573074;6745.392914637706;6398.904016439664;6411.4870810336;6492.383223593751;6496.545241833026;6516.804495865132;6331.683415829282;6481.449076828522;6533.607983521004;6599.307072757291;6609.570377925419;6594.340565943367;6619.437347825488;6619.50353723463;6631.270560238467;6637.336266373517;6342.619442833445;6380.138681278154;6412.326705695835;6434.453071488789;6486.837829054311;6476.6114033158165;6479.222493300834;6483.578567393104;6492.058651495601;6500.154979852589;6397.552171347961;6435.2599451063725;6439.935600643934;6443.935560644333;6446.5165112615805;6440.484761219185;6479.254885688206;6497.707603157964;6543.672816359068;6602.966985165043;6119.173911522065;6195.628262304276;6268.592541484789;6351.777687780906;6379 19:08:54 INFO - PID 4988 | |1;ext.html;773.9187385324541;815.4454970619976;846.7248144353085;871.4727589808164;877.8112705768259;40068.59931400685;40853.387199192;40863.387049194214;40870.38694419586;41082.38376424356;36548.81725591368;36634.8168259159;36684.63315366845;36748.63251367486;36817.63182368175;6720.899186512194;6849.315068493136;6849.315068493161;6849.691763870613;6851.828704282383;6763.289854565273;6799.626020568867;6813.761518346859;6823.556468829535;6839.1451068616425;7379.778606641809;7510.436717246201;7525.096988361404;7552.622368881562;7566.848663026736;7433.962830185868;7471.25287471254;7472.887906681404;7473.588952607632;7489.438292128112;7241.963790181016;7411.518251313647;7435.702571897117;7503.512271702377;7544.170141284454;38231.61768382308;38824.80587597072;38847.61152388497;39082.60917390818;39128.804355978325;3496.4580490024086;3552.6980206682465;3555.7510974231814;3558.395072837624;3560.305740380627;31581.84209078963;31617;31631.367372652418;31664.366712665847;31675.20811979696;4763.166445871993;4781.976090119562;4806.3511425957395;4842.564169224752;4855.781489832966;181715;184061;185656;189802;189910;48875.75562122238;49109.26336104961;49697.503024969286;49836.25245621319;49945;52072;52102.21846672303;52121.2181817273;52191.73904130455;52265.216021759705;14494.782578261334;14603.123812571279;14681.339339729524;14699.706005879823;14845.480408185878;11859.70350741221;11885;11944.163908526494;11985.34080625574;11996.760064798655;14468.638284042772;14470.710585788436;14497.782533262009;14631.195284259467;14675.92662036683;5721.5136713379;5759.424057594291;5766.711664416763;5766.826995190151;5966.134910437962;974.6296407365156;980.6028558433845;982.7150126463389;999.3903718731568;1011.9797604047877;21366;21414.143434262765;21581.56836863254;21836.563268734535;21977.560448790933;1061.4056128568027;1062.675883855416;1101.2786624760795;1102.3441052573705;1113.287496002559;11413;11701.88298117008;11805.586804461802;11859.288442693465;11883.762324753456;230209;233189;233227;233353;234631;53315.46684533105;53454.19818702723;53515.197272040954;53674;53988.730056349465;1433.5054406229833;1460.0801495058258;1464.912105273687;1467.955961321162;1485.4355344969058;21326.573468530853;22581.887090564443;27215.911363545238;28012.29969250785;28236;51698.48301516937;51899.48100518947;51926.22110668267;51966.74016630044;51983.74008129935;204233;204987;205767.8846423033;206393;207756;33711.32577348488;33810.15474613154;36020.09949751172;36237;36405.81797090998;44254;46865.062698746515;46972.53027469818;47196;47571;33130.66869331276;33755;33958.83020584881;34515;34949.30101397907;31662;32994.67005329916;33983.320333593685;34157.829210853786;34670.65329346775;36752.816235918646;36946.261074777816;37629.247415050995;37806.62193378031;38155;32628.510572340958;33547.161320966195;33616.83191584027;33652.326953461285;33969.49045764266;23082.76917230806;23127.190548330727;23973.880130599235;24508;24610.50778984446 19:08:54 INFO - PID 4988 | |2;jquery.html;571.6570057965222;571.7684337843173;575.5827025406578;585.9912101318481;587.4918195760666;21373.67939480907;22142.114315427403;22191.556168876632;22203.777962220393;22218.333449996484;24861.129860454887;26020.21939341818;27342.179734607944;27390.589141162898;27638.30904227395;6500.837479063026;6627.900581491282;6660.666966651672;6667.366600172976;6673.599584024974;6220.657863817488;6591.736330546796;6625.271220165778;6625.569337993015;6628.2046154461295;6507.251666058417;6509.056186852904;6517.315681853384;6527.575707579016;6529.5429319947625;6478.319776423478;6479.35206479353;6480.837979050514;6482.967585162091;6493.545451818398;5993.370696076893;6002.609830361012;6043.335233124397;6049.092636104576;6054.485368743662;27632.309192270353;29451.41097178066;29927.251818704488;30052;30089.548656770166;1924.0956750327323;1960.696092105726;1965.0371318054051;1965.626530959113;1968.7932767059397;18280.360187393377;19016.239350425967;19028.71456928147;19131.904340478348;19160.71258931117;2224.922127725538;2290.404494831339;2296.5292115116526;2328.871912044837;2334.3813889319345;134594;136307;137795;138588;138697;14083.366248518842;14683.632909177357;14697;14895.659390654893;15659.451919182773;23450.765492344857;23498.412539686644;23520.176793812134;23626.881865590563;23629.7637023631;10043.548040338203;10228.130608898178;10322.638707645196;10332.948335258427;10381.377117372831;9338.159565639126;9502.952485237529;9533.189678877234;9606.951965240269;9652.90347096534;8648.78378040554;9166.81666366669;9362;9429.245660347156;9541.284403669753;2621.9868900655374;2688.986555067212;2711.6745990481268;2736.2065001149444;2782.290515918428;933.8879334479906;936.1060187520901;950.4059962523423;970.96601618943;983.2674657380154;18268.451946441626;18592.628147436975;18908.43274701761;19253.22987080501;19495.512612184808;1010.8231059564547;1044.074875083896;1044.6448207609449;1065.1265961911313;1068.2095249515303;10441.485984532352;10545.038626692662;10553;11059.612913548148;11219;451324;459113;463947;468299;534141;112602.43698781454;114382.42808785902;119529.40235298942;119607.40196298962;119814.40092799481;1259.9370031498572;1304.2044352944506;1318.815365848782;1323.973520529584;1327.356232227369;19870.205191792746;20046;20207.191712331343;20445.897770511052;20700.896495517427;56767.432325677866;58058.7097064512;58444;59576.40423595709;59863.700681498056;67285.32714672986;70357.64821175861;71126.28873711197;71136.28863711504;71328.64335678496;14713.264336783332;14997.800175986113;15145.545633630569;15261.23693815327;15267.23663816827;23963.400914977265;24013.27960161198;24062.639060414458;24066.278011659677;24300.027998879847;17380.739288910423;18403.079846007913;18808.15363308627;18813.153408096943;18828;15686.137262450675;17074.48776536706;17185.39851105205;17551.736723949405;18413.63172736511;18802.52993675169;20248.392548223575;20394.592108157456;20436.18255269832;20488.692669610267;14562.490312839423;14653.340599673253;14858.851411485746;14997.700045998801;15019;19195.520111997314;19272.13275402582;19293.131809068906;19405;19448.513787155433 19:08:54 INFO - PID 4988 | |3;mootools.html;1333.7465881482517;1393.8257717785277;1393.9512117075903;1403.4666826605887;1405.1358414575034;13169.604911852648;13580.796288055688;13806.447742090317;13863.584092477216;13902.37439315232;14019.719605607906;14284.285785710725;14288.642783930407;14289.214093224868;14295.428182872673;2548.4520828021923;2603.0238660502314;2604.557225271699;2605.0621776160565;2608.882600282992;2624.291441310845;2747.409306998995;2748.175547335801;2748.6014527893444;2749.381389187427;2634.222904243243;2667.5598526243148;2692.623032775413;2695.460907818444;2705.377763114485;2563.9999999999814;2623.6326914232022;2628.5794272916337;2640.102365195833;2670.27902466333;2443.3647251714506;2450.816188785848;2455.472073504205;2460.495598402323;2472.6167444046023;13407.396667149904;13664.180149190981;13671.111377760413;13679.452821887113;13690.52083177084;7295.671694773748;7588.165301816795;7638.732644357421;7644.273793989562;7652.7704168875025;4879.926801097987;5097.668651537638;5137.61467889906;5165.173572228463;5193.324867767166;1824.7354133650679;1868.9252429902788;1884.3498992847447;1927;1931.4398824340924;21239.469013274636;21454.785452145436;21473.46316342088;21482;21505.462363441038;6264.404881536247;6415.518836087312;6552.410283074546;6577.440917522064;6578.440832529192;15190.620234494227;15226;15237.466688665843;15256.237188140549;15262.771058434133;7233.855322893618;7495.625218739041;7499.662515186829;7506.361959233417;7512.474126811071;6789.219239787488;6964.129483814523;7035.824104397431;7056.7530136444975;7059.8235044123285;4757.191277482836;4914.582260507826;4934.407871055496;4958;4981.9252711209365;1309.5220244610648;1312.6849556106465;1324.8675132486674;1326.2506683723666;1344.6638340414897;826.7519744076753;827.4828232354778;841.2554888923347;865.4244927123518;882.9735107946772;6399.392057754506;6562.901556476657;6599.47204223661;6691.197056353269;6694.196696396366;698.8916717908733;710.4813486155135;715.1204019056589;728.9489735718449;734.5372415378278;4175.561566035583;5085.618578606545;5120.334356533627;5168.508991645787;5191.117510023305;18569.5357616058;19488.415347539598;19532;19537.316193933144;19539.902300488407;18700.625987480173;19033;19047.238110475704;19060.428187154408;19062.142203600593;9984.611387573144;10629.84055239172;10647.307924985005;10653.360798352123;10664.520096595517;7843.333316667919;8312.501249925024;8473.237408633253;8488.151184881463;8504.53225072627;15694.215289235264;15805.209739513208;15947.282372293042;16032.198390080215;16275.186240688156;16059.678806424039;16124.27440765192;16570.502884913472;17051.91474042622;17205.311787528357;11238.044766194966;11570.652880413601;11570.768584628091;11572.421378931189;11582.247153934968;12834.486620535074;12936.547220847602;12937.741245175232;12950.093493455368;13057.934710326388;9595.760105997128;10068.69793906184;10173.287869849335;10383.94808025955;10689.091427228772;10010.699679009642;10221.846672299773;10414.531346089596;10463.476826158509;10691.679249622524;9542.093501117382;9644.228461722905;9652.951735241279;9661.71014869555;9665.855012174683;6795.1845778506895;6894.517383783087;6991.755288564876;7006;7017.473689473208;6934.370422950502;7011.158660960514;7017.789466316019;7157.534760240567;7214.386777124003 19:08:54 INFO - PID 4988 | |4;prototype.html;479.2212654436541;492.3205975753461;517.9974100129499;519;528.7277052318057;6174.475169610583;6182.28903676078;6186.814395568134;6236.469900058501;6246;5848.590598658096;5969.3135289441725;6021.367756385582;6047.788327408542;6088.45203931646;4844.612431005528;4879.292502587123;4888.242322440027;4898.559129678329;4913.975430122844;4729.7635118244125;4841.878953026167;4850.199717046701;4932.112219800434;4944.60443164546;4798.688085274446;4806.495317991613;4859.684120532172;4861.635377346695;4871.318015477836;4806.279058141272;4811.4707382187935;4823.372961515016;4837.879053023703;4849.806007759686;4340.739555626673;4358.280883654225;4375.409319741826;4407.779611019436;4426.889327766831;5997.340292567814;6009.369016253274;6036.909446358308;6042.788502402439;6074.635521868702;5563.638363506399;5619.943800561983;5644.068728659766;5664.688442135681;5729.398413166599;6424.807255782334;6444.258910225337;6457.709403076873;6461.256955450136;6482.416582507597;4763.595094416979;4777.522247775195;4798.808047678089;4801.231802911552;4810;6768.458523318172;6768.898466522957;6795.524313298071;6807.217170025411;6810.353016463428;4945.876353091129;4953.03756994403;4958.553730164231;4988.825391111366;4996.625253106032;4981.850544483599;5001.549860512571;5016.824411145592;5027.698338099725;5073.188289873602;5576.749046292926;5616.297962754656;5656.660600363992;5657.717114144276;5669.206311116447;6393.520485963571;6407.807765766941;6490.707918143695;6519.5436319457185;6563.901541476882;1649.934002639905;1697.7538256952919;1705.4883534939718;1721.510893077479;1721.8450339469507;1161;1171.7949358862165;1209.334865823811;1210.2738356985737;1227.2575092069349;5640.210370548127;5654.632448890891;5658.603897727202;5747.942520574825;5751.424857514216;6434.163558737428;6496.967515162489;6504;6596.175478065242;6646.803575356482;5657.575681823797;5681.812502186688;5704.71476426177;5737.311522617312;5770.509506691894;3544.4506101554302;3550.7217401735356;3578.284343131384;3589.94615080774;3594.5686517618055;6459.806205813833;6479.125318082093;6484.935150648527;6528.183977002875;6536.006518012052;6751.291114432914;6794.932050679528;6833.555818871758;6884.827879302958;6885.208201056842;6327.557071005078;6427.839304017437;6431.678416079178;6494.960806271069;6513.967430163008;6462.224533056064;6666;6682.63245521501;6695.832604184934;6717.56335838169;6520.152380190545;6591.736330546724;6602.372774586406;6606.306337834458;6618.6690665467495;6326.398992095744;6374.553781235269;6440;6481.935180648133;6515.28331883502;4857.198562237191;4886.65793394459;4916.508349165055;4919.827806026915;4928.654994150375;6646.401823835878;6654.334566543307;6658.500612453989;6695.631740254138;6785.864282714219;6273.811785646438;6475.222973243241;6478.578892371981;6519.250286217146;6540.411362977355;6340.30256671775;6430.553125546901;6433.935660643334;6452.774152904626;6458.451031662361;6092.847678807888;6214.378562143749;6225.501959843111;6323;6325.810225693236;6304.936950630435;6344.206974128234;6387;6438.484921206198;6493.642849643315;6187.504999599932;6240.4071613196675;6273.466755325666;6290.842728931813;6303.338149494237 19:08:54 INFO - PID 4988 | |5;yui.html;908.1644886704236;913.9954300228499;935.1536859142474;936.3352020065753;940.7742141885948;18114;18983.24067037317;19059.523511912208;19104.904475477637;19195.52011199719;16527.83472165278;16921.492355229333;17043.82956170438;19529.316473923416;21473.892630536826;1038.875334959804;1066.653337665258;1066.8933106689308;1071.036067539213;1071.5231721883765;1057.1701214546583;1057.5029736024057;1058.1270451877233;1058.8570542976677;1062.8458873463344;1021.7854250607381;1105.0165352835982;1115.5036008976008;1120.8262719278525;1122.7978963786516;1109.1736656191108;1109.4397329348708;1109.7724966381872;1110.5335758981248;1111.4887151910132;795.085651500773;799.2007992007992;799.5122974985254;799.6521513141744;802.009518244967;18692.34576789806;19231.423057308304;19301.22795088195;19455.80544194554;19831.107600158026;20026.1989520419;20457;20647.69028464574;20774.58450830975;20814;16352.591185220346;16362.363763623662;16394.75407868871;16499.422520211854;16564.75152872708;3563.233904710474;3572.6605972432835;3587.246678197582;3594.6764791168657;3596.28074385124;118891;121833;123364.38317808443;124823;127933;15667.529974100795;16234.188290585424;16234.350625975065;16274.67450651004;16307.1031093291;29242.561361579592;29938.80244790184;30203.848980755396;30228.69771302259;30264;8935.508547029976;8991.685291014783;9014.504202268807;9016.23362014223;9048.185663290336;4116.403121547359;4253.128108737701;4285.61429471349;4366.279563871925;4379.562043795659;5205.453427390145;5216.347956505437;5354.625176237626;5360.785568577213;5361.865953351119;1068.3056013591072;1069.2087854987253;1073.7691396349821;1074.462768615692;1075.1398880895408;664.8504086580481;673.474689742002;682.4506272450725;701.2006312803409;714.8034290570134;11513.30920144794;11720.88279117215;11892.821607675893;12269.447874845653;12419.689507762378;680.843406016609;684.5755631508497;707.3492387003969;714.6141083814786;717.0069453806516;5355.973220133952;5405.135178371442;5432.456754324615;5530.917036244459;5629.662220266715;104719;108753.45623271832;109366;112110;113899;93283;95628.52185739166;98990.5050474743;100304;102419;85212;85390.57304713437;85500.57249713836;87236;88516;10353.792924141626;10548.525316360628;10826.837597435888;10991.670249892515;12602.747945041232;35848.4622730654;36662.8166859164;37431.25137497289;38750.80624596859;38908.41637375498;68360;70199;71765.28234717586;78046.6097669508;79396.60301698455;19247.615047699248;19330.8066919329;19796.80203198007;19944.401667949984;19968.201271948958;21463.57072858565;21507.677384838928;21787.564248715255;22165.889170554045;22652.433689157904;19278.13248403853;19533.60932781308;19834.60330793347;20051.49871253172;20101.49746256355;18638.440846774618;19968.77229214364;20018.29935952293;20024.098915549126;20099.497512562302;17804.287828487235;18722.71915921235;19174.61650767005;19180.232790688216;19269.80730192736;13668.52160174389;13708.108972916729;14109;14265.42938282457;14716.337764800395;13937.58187254384;14063.085899416505;14223.857761422667;14558.636034099232;14885.553433397015 19:08:54 INFO - PID 4988 | __end_tp_report 19:08:54 INFO - PID 4988 | __start_cc_report 19:08:54 INFO - PID 4988 | _x_x_mozilla_cycle_collect,371 19:08:54 INFO - PID 4988 | __end_cc_report 19:08:54 INFO - PID 4988 | __startTimestamp1501121334351__endTimestamp 19:08:54 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | ------- Summary: start ------- 19:08:54 INFO - PID 4988 | Number of tests: 6 19:08:54 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | [#0] dojo.html Cycles:165 Average:6085.19 Median:6380.14 stddev:726.80 (11.4%) stddev-sans-first:689.32 19:08:54 INFO - PID 4988 | Values: 3064.8 3068.3 3072.9 3105.5 3143.8 6108.0 6125.7 6130.7 6131.2 6164.4 6198.3 6245.9 6246.8 6274.3 6274.4 5613.8 5674.0 5700.2 5750.3 5763.7 5481.6 5591.6 5615.6 5630.5 5687.5 5600.4 5693.5 5704.2 5705.3 5725.8 5624.9 5644.3 5699.2 5719.5 5720.9 5450.9 5600.2 5638.0 5646.9 5680.2 6022.7 6050.0 6061.2 6101.7 6102.9 6524.6 6592.8 6600.3 6617.2 6642.2 6583.8 6614.2 6678.4 6716.0 6750.0 6052.9 6148.5 6152.3 6239.5 6263.5 6694.0 6713.8 6725.3 6727.6 6737.3 6404.2 6419.0 6436.0 6449.3 6533.1 6578.5 6593.4 6598.8 6601.2 6602.7 6586.8 6601.2 6607.7 6614.8 6627.3 6535.6 6546.2 6550.1 6650.9 6654.9 5220.2 5298.7 5307.7 5361.0 5375.1 4557.7 4563.7 4579.9 4584.6 4591.3 5700.3 5703.0 5703.2 5707.9 5716.3 6670.9 6697.1 6704.4 6711.4 6719.6 5598.7 5620.1 5688.7 5694.0 5701.6 5719.7 5760.3 5781.6 5817.4 5868.9 6461.0 6469.7 6478.8 6480.1 6483.7 6589.7 6692.3 6702.6 6702.7 6745.4 6398.9 6411.5 6492.4 6496.5 6516.8 6331.7 6481.4 6533.6 6599.3 6609.6 6594.3 6619.4 6619.5 6631.3 6637.3 6342.6 6380.1 6412.3 6434.5 6486.8 6476.6 6479.2 6483.6 6492.1 6500.2 6397.6 6435.3 6439.9 6443.9 6446.5 6440.5 6479.3 6497.7 6543.7 6603.0 6119.2 6195.6 6268.6 6351.8 6379.0 19:08:54 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | [#1] ext.html Cycles:180 Average:38297.66 Median:36477.32 stddev:54341.74 (149.0%) stddev-sans-first:54421.13 19:08:54 INFO - PID 4988 | Values: 773.9 815.4 846.7 871.5 877.8 40068.6 40853.4 40863.4 40870.4 41082.4 36548.8 36634.8 36684.6 36748.6 36817.6 6720.9 6849.3 6849.3 6849.7 6851.8 6763.3 6799.6 6813.8 6823.6 6839.1 7379.8 7510.4 7525.1 7552.6 7566.8 7434.0 7471.3 7472.9 7473.6 7489.4 7242.0 7411.5 7435.7 7503.5 7544.2 38231.6 38824.8 38847.6 39082.6 39128.8 3496.5 3552.7 3555.8 3558.4 3560.3 31581.8 31617.0 31631.4 31664.4 31675.2 4763.2 4782.0 4806.4 4842.6 4855.8 181715.0 184061.0 185656.0 189802.0 189910.0 48875.8 49109.3 49697.5 49836.3 49945.0 52072.0 52102.2 52121.2 52191.7 52265.2 14494.8 14603.1 14681.3 14699.7 14845.5 11859.7 11885.0 11944.2 11985.3 11996.8 14468.6 14470.7 14497.8 14631.2 14675.9 5721.5 5759.4 5766.7 5766.8 5966.1 974.6 980.6 982.7 999.4 1012.0 21366.0 21414.1 21581.6 21836.6 21977.6 1061.4 1062.7 1101.3 1102.3 1113.3 11413.0 11701.9 11805.6 11859.3 11883.8 230209.0 233189.0 233227.0 233353.0 234631.0 53315.5 53454.2 53515.2 53674.0 53988.7 1433.5 1460.1 1464.9 1468.0 1485.4 21326.6 22581.9 27215.9 28012.3 28236.0 51698.5 51899.5 51926.2 51966.7 51983.7 204233.0 204987.0 205767.9 206393.0 207756.0 33711.3 33810.2 36020.1 36237.0 36405.8 44254.0 46865.1 46972.5 47196.0 47571.0 33130.7 33755.0 33958.8 34515.0 34949.3 31662.0 32994.7 33983.3 34157.8 34670.7 36752.8 36946.3 37629.2 37806.6 38155.0 32628.5 33547.2 33616.8 33652.3 33969.5 23082.8 23127.2 23973.9 24508.0 24610.5 19:08:54 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | [#2] jquery.html Cycles:180 Average:34580.54 Median:2257.66 stddev:80463.00 (3564.0%) stddev-sans-first:80648.20 19:08:54 INFO - PID 4988 | Values: 571.7 571.8 575.6 586.0 587.5 21373.7 22142.1 22191.6 22203.8 22218.3 24861.1 26020.2 27342.2 27390.6 27638.3 6500.8 6627.9 6660.7 6667.4 6673.6 6220.7 6591.7 6625.3 6625.6 6628.2 6507.3 6509.1 6517.3 6527.6 6529.5 6478.3 6479.4 6480.8 6483.0 6493.5 5993.4 6002.6 6043.3 6049.1 6054.5 27632.3 29451.4 29927.3 30052.0 30089.5 1924.1 1960.7 1965.0 1965.6 1968.8 18280.4 19016.2 19028.7 19131.9 19160.7 2224.9 2290.4 2296.5 2328.9 2334.4 134594.0 136307.0 137795.0 138588.0 138697.0 14083.4 14683.6 14697.0 14895.7 15659.5 23450.8 23498.4 23520.2 23626.9 23629.8 10043.5 10228.1 10322.6 10332.9 10381.4 9338.2 9503.0 9533.2 9607.0 9652.9 8648.8 9166.8 9362.0 9429.2 9541.3 2622.0 2689.0 2711.7 2736.2 2782.3 933.9 936.1 950.4 971.0 983.3 18268.5 18592.6 18908.4 19253.2 19495.5 1010.8 1044.1 1044.6 1065.1 1068.2 10441.5 10545.0 10553.0 11059.6 11219.0 451324.0 459113.0 463947.0 468299.0 534141.0 112602.4 114382.4 119529.4 119607.4 119814.4 1259.9 1304.2 1318.8 1324.0 1327.4 19870.2 20046.0 20207.2 20445.9 20700.9 56767.4 58058.7 58444.0 59576.4 59863.7 67285.3 70357.6 71126.3 71136.3 71328.6 14713.3 14997.8 15145.5 15261.2 15267.2 23963.4 24013.3 24062.6 24066.3 24300.0 17380.7 18403.1 18808.2 18813.2 18828.0 15686.1 17074.5 17185.4 17551.7 18413.6 18802.5 20248.4 20394.6 20436.2 20488.7 14562.5 14653.3 14858.9 14997.7 15019.0 19195.5 19272.1 19293.1 19405.0 19448.5 19:08:54 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | [#3] mootools.html Cycles:180 Average:8494.05 Median:2603.79 stddev:5741.31 (220.5%) stddev-sans-first:5732.20 19:08:54 INFO - PID 4988 | Values: 1333.7 1393.8 1394.0 1403.5 1405.1 13169.6 13580.8 13806.4 13863.6 13902.4 14019.7 14284.3 14288.6 14289.2 14295.4 2548.5 2603.0 2604.6 2605.1 2608.9 2624.3 2747.4 2748.2 2748.6 2749.4 2634.2 2667.6 2692.6 2695.5 2705.4 2564.0 2623.6 2628.6 2640.1 2670.3 2443.4 2450.8 2455.5 2460.5 2472.6 13407.4 13664.2 13671.1 13679.5 13690.5 7295.7 7588.2 7638.7 7644.3 7652.8 4879.9 5097.7 5137.6 5165.2 5193.3 1824.7 1868.9 1884.3 1927.0 1931.4 21239.5 21454.8 21473.5 21482.0 21505.5 6264.4 6415.5 6552.4 6577.4 6578.4 15190.6 15226.0 15237.5 15256.2 15262.8 7233.9 7495.6 7499.7 7506.4 7512.5 6789.2 6964.1 7035.8 7056.8 7059.8 4757.2 4914.6 4934.4 4958.0 4981.9 1309.5 1312.7 1324.9 1326.3 1344.7 826.8 827.5 841.3 865.4 883.0 6399.4 6562.9 6599.5 6691.2 6694.2 698.9 710.5 715.1 728.9 734.5 4175.6 5085.6 5120.3 5168.5 5191.1 18569.5 19488.4 19532.0 19537.3 19539.9 18700.6 19033.0 19047.2 19060.4 19062.1 9984.6 10629.8 10647.3 10653.4 10664.5 7843.3 8312.5 8473.2 8488.2 8504.5 15694.2 15805.2 15947.3 16032.2 16275.2 16059.7 16124.3 16570.5 17051.9 17205.3 11238.0 11570.7 11570.8 11572.4 11582.2 12834.5 12936.5 12937.7 12950.1 13057.9 9595.8 10068.7 10173.3 10383.9 10689.1 10010.7 10221.8 10414.5 10463.5 10691.7 9542.1 9644.2 9653.0 9661.7 9665.9 6795.2 6894.5 6991.8 7006.0 7017.5 6934.4 7011.2 7017.8 7157.5 7214.4 19:08:54 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | [#4] prototype.html Cycles:180 Average:5430.55 Median:6039.85 stddev:1528.83 (25.3%) stddev-sans-first:1487.27 19:08:54 INFO - PID 4988 | Values: 479.2 492.3 518.0 519.0 528.7 6174.5 6182.3 6186.8 6236.5 6246.0 5848.6 5969.3 6021.4 6047.8 6088.5 4844.6 4879.3 4888.2 4898.6 4914.0 4729.8 4841.9 4850.2 4932.1 4944.6 4798.7 4806.5 4859.7 4861.6 4871.3 4806.3 4811.5 4823.4 4837.9 4849.8 4340.7 4358.3 4375.4 4407.8 4426.9 5997.3 6009.4 6036.9 6042.8 6074.6 5563.6 5619.9 5644.1 5664.7 5729.4 6424.8 6444.3 6457.7 6461.3 6482.4 4763.6 4777.5 4798.8 4801.2 4810.0 6768.5 6768.9 6795.5 6807.2 6810.4 4945.9 4953.0 4958.6 4988.8 4996.6 4981.9 5001.5 5016.8 5027.7 5073.2 5576.7 5616.3 5656.7 5657.7 5669.2 6393.5 6407.8 6490.7 6519.5 6563.9 1649.9 1697.8 1705.5 1721.5 1721.8 1161.0 1171.8 1209.3 1210.3 1227.3 5640.2 5654.6 5658.6 5747.9 5751.4 6434.2 6497.0 6504.0 6596.2 6646.8 5657.6 5681.8 5704.7 5737.3 5770.5 3544.5 3550.7 3578.3 3589.9 3594.6 6459.8 6479.1 6484.9 6528.2 6536.0 6751.3 6794.9 6833.6 6884.8 6885.2 6327.6 6427.8 6431.7 6495.0 6514.0 6462.2 6666.0 6682.6 6695.8 6717.6 6520.2 6591.7 6602.4 6606.3 6618.7 6326.4 6374.6 6440.0 6481.9 6515.3 4857.2 4886.7 4916.5 4919.8 4928.7 6646.4 6654.3 6658.5 6695.6 6785.9 6273.8 6475.2 6478.6 6519.3 6540.4 6340.3 6430.6 6433.9 6452.8 6458.5 6092.8 6214.4 6225.5 6323.0 6325.8 6304.9 6344.2 6387.0 6438.5 6493.6 6187.5 6240.4 6273.5 6290.8 6303.3 19:08:54 INFO - PID 4988 | 19:08:54 INFO - PID 4988 | [#5] yui.html Cycles:180 Average:23772.72 Median:19813.95 stddev:31997.81 (161.5%) stddev-sans-first:32041.51 19:08:54 INFO - PID 4988 | Values: 908.2 914.0 935.2 936.3 940.8 18114.0 18983.2 19059.5 19104.9 19195.5 16527.8 16921.5 17043.8 19529.3 21473.9 1038.9 1066.7 1066.9 1071.0 1071.5 1057.2 1057.5 1058.1 1058.9 1062.8 1021.8 1105.0 1115.5 1120.8 1122.8 1109.2 1109.4 1109.8 1110.5 1111.5 795.1 799.2 799.5 799.7 802.0 18692.3 19231.4 19301.2 19455.8 19831.1 20026.2 20457.0 20647.7 20774.6 20814.0 16352.6 16362.4 16394.8 16499.4 16564.8 3563.2 3572.7 3587.2 3594.7 3596.3 118891.0 121833.0 123364.4 124823.0 127933.0 15667.5 16234.2 16234.4 16274.7 16307.1 29242.6 29938.8 30203.8 30228.7 30264.0 8935.5 8991.7 9014.5 9016.2 9048.2 4116.4 4253.1 4285.6 4366.3 4379.6 5205.5 5216.3 5354.6 5360.8 5361.9 1068.3 1069.2 1073.8 1074.5 1075.1 664.9 673.5 682.5 701.2 714.8 11513.3 11720.9 11892.8 12269.4 12419.7 680.8 684.6 707.3 714.6 717.0 5356.0 5405.1 5432.5 5530.9 5629.7 104719.0 108753.5 109366.0 112110.0 113899.0 93283.0 95628.5 98990.5 100304.0 102419.0 85212.0 85390.6 85500.6 87236.0 88516.0 10353.8 10548.5 10826.8 10991.7 12602.7 35848.5 36662.8 37431.3 38750.8 38908.4 68360.0 70199.0 71765.3 78046.6 79396.6 19247.6 19330.8 19796.8 19944.4 19968.2 21463.6 21507.7 21787.6 22165.9 22652.4 19278.1 19533.6 19834.6 20051.5 20101.5 18638.4 19968.8 20018.3 20024.1 20099.5 17804.3 18722.7 19174.6 19180.2 19269.8 13668.5 13708.1 14109.0 14265.4 14716.3 13937.6 14063.1 14223.9 14558.6 14885.6 19:08:54 INFO - PID 4988 | -------- Summary: end -------- 19:08:54 INFO - PID 4988 | 19:08:54 INFO - TEST-INFO | 4988: exit 0 19:08:54 INFO - TEST-OK | dromaeo_css | took 1112998ms 19:08:54 INFO - TEST-START | kraken 19:08:54 INFO - Initialising browser for kraken test... 19:08:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html -profile /tmp/tmpn_Y1pQ/profile 19:08:54 INFO - TEST-INFO | started process 5365 (/builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html) 19:09:00 INFO - TEST-INFO | 5365: exit 0 19:09:00 INFO - Browser initialized. 19:09:00 INFO - Running cycle 1/1 for kraken test... 19:09:00 INFO - TEST-INFO | started process 5592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn_Y1pQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:01 INFO - PID 5592 | 19:09:01 INFO - PID 5592 | (/builds/slave/test/build/application/firefox/firefox:5647): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:09:01 INFO - PID 5592 | 19:09:12 INFO - PID 5592 | RSS: Main: 170270720 19:09:12 INFO - PID 5592 | 19:09:14 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-beat-detection) 19:09:15 INFO - PID 5592 | RSS: Main: 176742400 19:09:15 INFO - PID 5592 | 19:09:18 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-dft) 19:09:19 INFO - PID 5592 | RSS: Main: 177176576 19:09:19 INFO - PID 5592 | 19:09:22 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-fft) 19:09:22 INFO - PID 5592 | RSS: Main: 172294144 19:09:22 INFO - PID 5592 | 19:09:24 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-oscillator) 19:09:25 INFO - PID 5592 | RSS: Main: 172724224 19:09:25 INFO - PID 5592 | 19:09:27 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:09:28 INFO - PID 5592 | RSS: Main: 172773376 19:09:28 INFO - PID 5592 | 19:09:31 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-darkroom) 19:09:32 INFO - PID 5592 | RSS: Main: 175419392 19:09:32 INFO - PID 5592 | 19:09:35 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-desaturate) 19:09:36 INFO - PID 5592 | RSS: Main: 175239168 19:09:36 INFO - PID 5592 | 19:09:39 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43401/tests/kraken/driver.html?testName=json-parse-financial) 19:09:39 INFO - PID 5592 | RSS: Main: 176394240 19:09:39 INFO - PID 5592 | 19:09:41 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:09:41 INFO - PID 5592 | RSS: Main: 176295936 19:09:41 INFO - PID 5592 | 19:09:43 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:09:44 INFO - PID 5592 | RSS: Main: 173744128 19:09:44 INFO - PID 5592 | 19:09:46 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:09:47 INFO - PID 5592 | RSS: Main: 173314048 19:09:47 INFO - PID 5592 | 19:09:49 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:09:50 INFO - PID 5592 | RSS: Main: 173907968 19:09:50 INFO - PID 5592 | 19:09:53 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:09:54 INFO - PID 5592 | RSS: Main: 174215168 19:09:54 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43401/tests/kraken/driver.html?testName=ai-astar) 19:09:56 INFO - PID 5592 | RSS: Main: 175562752 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | __start_tp_report 19:09:56 INFO - PID 5592 | _x_x_mozilla_page_load 19:09:56 INFO - PID 5592 | _x_x_mozilla_page_load_details 19:09:56 INFO - PID 5592 | |i|pagename|runs| 19:09:56 INFO - PID 5592 | |0;ai-astar;99;110;101;108;108;109;110;100;108;117 19:09:56 INFO - PID 5592 | |1;audio-beat-detection;151;117;141;186;118;147;151;119;167;118 19:09:56 INFO - PID 5592 | |2;audio-dft;163;162;161;162;164;163;168;165;163;169 19:09:56 INFO - PID 5592 | |3;audio-fft;74;76;74;179;78;75;74;91;95;76 19:09:56 INFO - PID 5592 | |4;audio-oscillator;79;78;131;78;80;78;127;78;79;121 19:09:56 INFO - PID 5592 | |5;imaging-gaussian-blur;114;114;114;113;114;114;114;113;114;115 19:09:56 INFO - PID 5592 | |6;imaging-darkroom;150;151;152;150;150;151;150;161;151;150 19:09:56 INFO - PID 5592 | |7;imaging-desaturate;95;94;99;95;97;96;95;94;94;94 19:09:56 INFO - PID 5592 | |8;json-parse-financial;55;55;55;55;56;55;62;54;55;55 19:09:56 INFO - PID 5592 | |9;json-stringify-tinderbox;55;55;55;54;54;54;54;54;54;54 19:09:56 INFO - PID 5592 | |10;stanford-crypto-aes;78;78;78;78;78;78;79;80;80;79 19:09:56 INFO - PID 5592 | |11;stanford-crypto-ccm;127;130;125;127;133;125;134;132;130;165 19:09:56 INFO - PID 5592 | |12;stanford-crypto-pbkdf2;190;180;172;175;174;177;181;174;176;176 19:09:56 INFO - PID 5592 | |13;stanford-crypto-sha256-iterative;76;69;69;68;67;70;66;67;69;66 19:09:56 INFO - PID 5592 | __end_tp_report 19:09:56 INFO - PID 5592 | __start_cc_report 19:09:56 INFO - PID 5592 | _x_x_mozilla_cycle_collect,953 19:09:56 INFO - PID 5592 | __end_cc_report 19:09:56 INFO - PID 5592 | __startTimestamp1501121396378__endTimestamp 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | ------- Summary: start ------- 19:09:56 INFO - PID 5592 | Number of tests: 14 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#0] ai-astar Cycles:10 Average:107.00 Median:109.50 stddev:5.52 (5.0%) stddev-sans-first:5.04 19:09:56 INFO - PID 5592 | Values: 99.0 110.0 101.0 108.0 108.0 109.0 110.0 100.0 108.0 117.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:149.00 stddev:23.69 (15.9%) stddev-sans-first:24.88 19:09:56 INFO - PID 5592 | Values: 151.0 117.0 141.0 186.0 118.0 147.0 151.0 119.0 167.0 118.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.62 (1.6%) stddev-sans-first:2.76 19:09:56 INFO - PID 5592 | Values: 163.0 162.0 161.0 162.0 164.0 163.0 168.0 165.0 163.0 169.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#3] audio-fft Cycles:10 Average:89.20 Median:76.00 stddev:32.44 (42.7%) stddev-sans-first:33.94 19:09:56 INFO - PID 5592 | Values: 74.0 76.0 74.0 179.0 78.0 75.0 74.0 91.0 95.0 76.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:78.00 stddev:23.20 (29.7%) stddev-sans-first:24.06 19:09:56 INFO - PID 5592 | Values: 79.0 78.0 131.0 78.0 80.0 78.0 127.0 78.0 79.0 121.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 19:09:56 INFO - PID 5592 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 115.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:3.37 (2.2%) stddev-sans-first:3.53 19:09:56 INFO - PID 5592 | Values: 150.0 151.0 152.0 150.0 150.0 151.0 150.0 161.0 151.0 150.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.64 (1.7%) stddev-sans-first:1.73 19:09:56 INFO - PID 5592 | Values: 95.0 94.0 99.0 95.0 97.0 96.0 95.0 94.0 94.0 94.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:2.26 (4.1%) stddev-sans-first:2.39 19:09:56 INFO - PID 5592 | Values: 55.0 55.0 55.0 55.0 56.0 55.0 62.0 54.0 55.0 55.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 19:09:56 INFO - PID 5592 | Values: 55.0 55.0 55.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.50 stddev:0.84 (1.1%) stddev-sans-first:0.87 19:09:56 INFO - PID 5592 | Values: 78.0 78.0 78.0 78.0 78.0 78.0 79.0 80.0 80.0 79.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:131.00 stddev:11.75 (9.0%) stddev-sans-first:12.28 19:09:56 INFO - PID 5592 | Values: 127.0 130.0 125.0 127.0 133.0 125.0 134.0 132.0 130.0 165.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:176.50 stddev:5.17 (2.9%) stddev-sans-first:2.89 19:09:56 INFO - PID 5592 | Values: 190.0 180.0 172.0 175.0 174.0 177.0 181.0 174.0 176.0 176.0 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.91 (4.2%) stddev-sans-first:1.45 19:09:56 INFO - PID 5592 | Values: 76.0 69.0 69.0 68.0 67.0 70.0 66.0 67.0 69.0 66.0 19:09:56 INFO - PID 5592 | -------- Summary: end -------- 19:09:56 INFO - PID 5592 | 19:09:56 INFO - PID 5592 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:09:57 INFO - TEST-INFO | 5592: exit 0 19:09:57 INFO - TEST-OK | kraken | took 62097ms 19:09:57 INFO - SUITE-END | took 1175s 19:09:57 INFO - Completed test suite (00:19:35) 19:09:57 INFO - javascript benchmark 19:09:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8417.70890093289, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.831434271114, 3068.2636167319847, 3072.907812765617, 3105.5496952941826, 3143.842807859608, 6108.0, 6125.663088530135, 6130.724117414716, 6131.233595800525, 6164.445199932005, 6198.318184999646, 6245.875082498347, 6246.843828904268, 6274.278457977334, 6274.372562743723, 5613.80351687691, 5674.0, 5700.201971723962, 5750.281214848144, 5763.711814409284, 5481.588880833953, 5591.580631452657, 5615.578831587647, 5630.465105814941, 5687.544996400299, 5600.411956744544, 5693.516051135658, 5704.201411802351, 5705.25831641886, 5725.828225153252, 5624.887502249973, 5644.322681278273, 5699.230603868507, 5719.542436605103, 5720.856978575527, 5450.890982180374, 5600.243967064435, 5638.0, 5646.887062258732, 5680.233168522238, 6022.6687532185715, 6050.031994880798, 6061.151438798572, 6101.725422356005, 6102.908456373158, 6524.641144737037, 6592.76925307612, 6600.339966003409, 6617.205935287748, 6642.236142843538, 6583.802485925382, 6614.2393624733295, 6678.43233325168, 6715.966420167917, 6750.021246919169, 6052.878942421127, 6148.538859585504, 6152.323244443108, 6239.469645080128, 6263.530235232331, 6693.966530167318, 6713.765018224436, 6725.2602213756445, 6727.596344219362, 6737.326267373223, 6404.1674582304, 6418.972964325685, 6436.034594810816, 6449.258335291408, 6533.085368048477, 6578.506612004119, 6593.3736295051895, 6598.802035938929, 6601.174853143357, 6602.7028783704845, 6586.8353291168105, 6601.240857301375, 6607.702653380513, 6614.801555953329, 6627.304133066055, 6535.607863528204, 6546.247181574085, 6550.0829883816305, 6650.933490665128, 6654.933450665529, 5220.1647736362, 5298.682079075268, 5307.65500242483, 5360.973195133999, 5375.086235340002, 4557.680962332671, 4563.703359281636, 4579.9084018319445, 4584.633229341644, 4591.265397536378, 5700.315962084494, 5703.030484817591, 5703.230063941398, 5707.914381284284, 5716.314042314949, 6670.899936500957, 6697.129373181455, 6704.396604305636, 6711.429528490035, 6719.596824190564, 5598.720063996784, 5620.100783874561, 5688.715564221772, 5694.0, 5701.572382071361, 5719.656820590778, 5760.337561180518, 5781.5952883298605, 5817.38917413674, 5868.911966320508, 6460.966245400713, 6469.708863101077, 6478.838029049311, 6480.092787009822, 6483.675816209171, 6589.736410543716, 6692.263850976486, 6702.631355275506, 6702.698378573074, 6745.392914637706, 6398.904016439664, 6411.4870810336, 6492.383223593751, 6496.545241833026, 6516.804495865132, 6331.683415829282, 6481.449076828522, 6533.607983521004, 6599.307072757291, 6609.570377925419, 6594.340565943367, 6619.437347825488, 6619.50353723463, 6631.270560238467, 6637.336266373517, 6342.619442833445, 6380.138681278154, 6412.326705695835, 6434.453071488789, 6486.837829054311, 6476.6114033158165, 6479.222493300834, 6483.578567393104, 6492.058651495601, 6500.154979852589, 6397.552171347961, 6435.2599451063725, 6439.935600643934, 6443.935560644333, 6446.5165112615805, 6440.484761219185, 6479.254885688206, 6497.707603157964, 6543.672816359068, 6602.966985165043, 6119.173911522065, 6195.628262304276, 6268.592541484789, 6351.777687780906, 6379.0], "value": 6029.726353391581, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.9187385324541, 815.4454970619976, 846.7248144353085, 871.4727589808164, 877.8112705768259, 40068.59931400685, 40853.387199192, 40863.387049194214, 40870.38694419586, 41082.38376424356, 36548.81725591368, 36634.8168259159, 36684.63315366845, 36748.63251367486, 36817.63182368175, 6720.899186512194, 6849.315068493136, 6849.315068493161, 6849.691763870613, 6851.828704282383, 6763.289854565273, 6799.626020568867, 6813.761518346859, 6823.556468829535, 6839.1451068616425, 7379.778606641809, 7510.436717246201, 7525.096988361404, 7552.622368881562, 7566.848663026736, 7433.962830185868, 7471.25287471254, 7472.887906681404, 7473.588952607632, 7489.438292128112, 7241.963790181016, 7411.518251313647, 7435.702571897117, 7503.512271702377, 7544.170141284454, 38231.61768382308, 38824.80587597072, 38847.61152388497, 39082.60917390818, 39128.804355978325, 3496.4580490024086, 3552.6980206682465, 3555.7510974231814, 3558.395072837624, 3560.305740380627, 31581.84209078963, 31617.0, 31631.367372652418, 31664.366712665847, 31675.20811979696, 4763.166445871993, 4781.976090119562, 4806.3511425957395, 4842.564169224752, 4855.781489832966, 181715.0, 184061.0, 185656.0, 189802.0, 189910.0, 48875.75562122238, 49109.26336104961, 49697.503024969286, 49836.25245621319, 49945.0, 52072.0, 52102.21846672303, 52121.2181817273, 52191.73904130455, 52265.216021759705, 14494.782578261334, 14603.123812571279, 14681.339339729524, 14699.706005879823, 14845.480408185878, 11859.70350741221, 11885.0, 11944.163908526494, 11985.34080625574, 11996.760064798655, 14468.638284042772, 14470.710585788436, 14497.782533262009, 14631.195284259467, 14675.92662036683, 5721.5136713379, 5759.424057594291, 5766.711664416763, 5766.826995190151, 5966.134910437962, 974.6296407365156, 980.6028558433845, 982.7150126463389, 999.3903718731568, 1011.9797604047877, 21366.0, 21414.143434262765, 21581.56836863254, 21836.563268734535, 21977.560448790933, 1061.4056128568027, 1062.675883855416, 1101.2786624760795, 1102.3441052573705, 1113.287496002559, 11413.0, 11701.88298117008, 11805.586804461802, 11859.288442693465, 11883.762324753456, 230209.0, 233189.0, 233227.0, 233353.0, 234631.0, 53315.46684533105, 53454.19818702723, 53515.197272040954, 53674.0, 53988.730056349465, 1433.5054406229833, 1460.0801495058258, 1464.912105273687, 1467.955961321162, 1485.4355344969058, 21326.573468530853, 22581.887090564443, 27215.911363545238, 28012.29969250785, 28236.0, 51698.48301516937, 51899.48100518947, 51926.22110668267, 51966.74016630044, 51983.74008129935, 204233.0, 204987.0, 205767.8846423033, 206393.0, 207756.0, 33711.32577348488, 33810.15474613154, 36020.09949751172, 36237.0, 36405.81797090998, 44254.0, 46865.062698746515, 46972.53027469818, 47196.0, 47571.0, 33130.66869331276, 33755.0, 33958.83020584881, 34515.0, 34949.30101397907, 31662.0, 32994.67005329916, 33983.320333593685, 34157.829210853786, 34670.65329346775, 36752.816235918646, 36946.261074777816, 37629.247415050995, 37806.62193378031, 38155.0, 32628.510572340958, 33547.161320966195, 33616.83191584027, 33652.326953461285, 33969.49045764266, 23082.76917230806, 23127.190548330727, 23973.880130599235, 24508.0, 24610.50778984446], "value": 17155.817521462788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.6570057965222, 571.7684337843173, 575.5827025406578, 585.9912101318481, 587.4918195760666, 21373.67939480907, 22142.114315427403, 22191.556168876632, 22203.777962220393, 22218.333449996484, 24861.129860454887, 26020.21939341818, 27342.179734607944, 27390.589141162898, 27638.30904227395, 6500.837479063026, 6627.900581491282, 6660.666966651672, 6667.366600172976, 6673.599584024974, 6220.657863817488, 6591.736330546796, 6625.271220165778, 6625.569337993015, 6628.2046154461295, 6507.251666058417, 6509.056186852904, 6517.315681853384, 6527.575707579016, 6529.5429319947625, 6478.319776423478, 6479.35206479353, 6480.837979050514, 6482.967585162091, 6493.545451818398, 5993.370696076893, 6002.609830361012, 6043.335233124397, 6049.092636104576, 6054.485368743662, 27632.309192270353, 29451.41097178066, 29927.251818704488, 30052.0, 30089.548656770166, 1924.0956750327323, 1960.696092105726, 1965.0371318054051, 1965.626530959113, 1968.7932767059397, 18280.360187393377, 19016.239350425967, 19028.71456928147, 19131.904340478348, 19160.71258931117, 2224.922127725538, 2290.404494831339, 2296.5292115116526, 2328.871912044837, 2334.3813889319345, 134594.0, 136307.0, 137795.0, 138588.0, 138697.0, 14083.366248518842, 14683.632909177357, 14697.0, 14895.659390654893, 15659.451919182773, 23450.765492344857, 23498.412539686644, 23520.176793812134, 23626.881865590563, 23629.7637023631, 10043.548040338203, 10228.130608898178, 10322.638707645196, 10332.948335258427, 10381.377117372831, 9338.159565639126, 9502.952485237529, 9533.189678877234, 9606.951965240269, 9652.90347096534, 8648.78378040554, 9166.81666366669, 9362.0, 9429.245660347156, 9541.284403669753, 2621.9868900655374, 2688.986555067212, 2711.6745990481268, 2736.2065001149444, 2782.290515918428, 933.8879334479906, 936.1060187520901, 950.4059962523423, 970.96601618943, 983.2674657380154, 18268.451946441626, 18592.628147436975, 18908.43274701761, 19253.22987080501, 19495.512612184808, 1010.8231059564547, 1044.074875083896, 1044.6448207609449, 1065.1265961911313, 1068.2095249515303, 10441.485984532352, 10545.038626692662, 10553.0, 11059.612913548148, 11219.0, 451324.0, 459113.0, 463947.0, 468299.0, 534141.0, 112602.43698781454, 114382.42808785902, 119529.40235298942, 119607.40196298962, 119814.40092799481, 1259.9370031498572, 1304.2044352944506, 1318.815365848782, 1323.973520529584, 1327.356232227369, 19870.205191792746, 20046.0, 20207.191712331343, 20445.897770511052, 20700.896495517427, 56767.432325677866, 58058.7097064512, 58444.0, 59576.40423595709, 59863.700681498056, 67285.32714672986, 70357.64821175861, 71126.28873711197, 71136.28863711504, 71328.64335678496, 14713.264336783332, 14997.800175986113, 15145.545633630569, 15261.23693815327, 15267.23663816827, 23963.400914977265, 24013.27960161198, 24062.639060414458, 24066.278011659677, 24300.027998879847, 17380.739288910423, 18403.079846007913, 18808.15363308627, 18813.153408096943, 18828.0, 15686.137262450675, 17074.48776536706, 17185.39851105205, 17551.736723949405, 18413.63172736511, 18802.52993675169, 20248.392548223575, 20394.592108157456, 20436.18255269832, 20488.692669610267, 14562.490312839423, 14653.340599673253, 14858.851411485746, 14997.700045998801, 15019.0, 19195.520111997314, 19272.13275402582, 19293.131809068906, 19405.0, 19448.513787155433], "value": 12079.033078783059, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.7465881482517, 1393.8257717785277, 1393.9512117075903, 1403.4666826605887, 1405.1358414575034, 13169.604911852648, 13580.796288055688, 13806.447742090317, 13863.584092477216, 13902.37439315232, 14019.719605607906, 14284.285785710725, 14288.642783930407, 14289.214093224868, 14295.428182872673, 2548.4520828021923, 2603.0238660502314, 2604.557225271699, 2605.0621776160565, 2608.882600282992, 2624.291441310845, 2747.409306998995, 2748.175547335801, 2748.6014527893444, 2749.381389187427, 2634.222904243243, 2667.5598526243148, 2692.623032775413, 2695.460907818444, 2705.377763114485, 2563.9999999999814, 2623.6326914232022, 2628.5794272916337, 2640.102365195833, 2670.27902466333, 2443.3647251714506, 2450.816188785848, 2455.472073504205, 2460.495598402323, 2472.6167444046023, 13407.396667149904, 13664.180149190981, 13671.111377760413, 13679.452821887113, 13690.52083177084, 7295.671694773748, 7588.165301816795, 7638.732644357421, 7644.273793989562, 7652.7704168875025, 4879.926801097987, 5097.668651537638, 5137.61467889906, 5165.173572228463, 5193.324867767166, 1824.7354133650679, 1868.9252429902788, 1884.3498992847447, 1927.0, 1931.4398824340924, 21239.469013274636, 21454.785452145436, 21473.46316342088, 21482.0, 21505.462363441038, 6264.404881536247, 6415.518836087312, 6552.410283074546, 6577.440917522064, 6578.440832529192, 15190.620234494227, 15226.0, 15237.466688665843, 15256.237188140549, 15262.771058434133, 7233.855322893618, 7495.625218739041, 7499.662515186829, 7506.361959233417, 7512.474126811071, 6789.219239787488, 6964.129483814523, 7035.824104397431, 7056.7530136444975, 7059.8235044123285, 4757.191277482836, 4914.582260507826, 4934.407871055496, 4958.0, 4981.9252711209365, 1309.5220244610648, 1312.6849556106465, 1324.8675132486674, 1326.2506683723666, 1344.6638340414897, 826.7519744076753, 827.4828232354778, 841.2554888923347, 865.4244927123518, 882.9735107946772, 6399.392057754506, 6562.901556476657, 6599.47204223661, 6691.197056353269, 6694.196696396366, 698.8916717908733, 710.4813486155135, 715.1204019056589, 728.9489735718449, 734.5372415378278, 4175.561566035583, 5085.618578606545, 5120.334356533627, 5168.508991645787, 5191.117510023305, 18569.5357616058, 19488.415347539598, 19532.0, 19537.316193933144, 19539.902300488407, 18700.625987480173, 19033.0, 19047.238110475704, 19060.428187154408, 19062.142203600593, 9984.611387573144, 10629.84055239172, 10647.307924985005, 10653.360798352123, 10664.520096595517, 7843.333316667919, 8312.501249925024, 8473.237408633253, 8488.151184881463, 8504.53225072627, 15694.215289235264, 15805.209739513208, 15947.282372293042, 16032.198390080215, 16275.186240688156, 16059.678806424039, 16124.27440765192, 16570.502884913472, 17051.91474042622, 17205.311787528357, 11238.044766194966, 11570.652880413601, 11570.768584628091, 11572.421378931189, 11582.247153934968, 12834.486620535074, 12936.547220847602, 12937.741245175232, 12950.093493455368, 13057.934710326388, 9595.760105997128, 10068.69793906184, 10173.287869849335, 10383.94808025955, 10689.091427228772, 10010.699679009642, 10221.846672299773, 10414.531346089596, 10463.476826158509, 10691.679249622524, 9542.093501117382, 9644.228461722905, 9652.951735241279, 9661.71014869555, 9665.855012174683, 6795.1845778506895, 6894.517383783087, 6991.755288564876, 7006.0, 7017.473689473208, 6934.370422950502, 7011.158660960514, 7017.789466316019, 7157.534760240567, 7214.386777124003], "value": 6176.742499794399, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.2212654436541, 492.3205975753461, 517.9974100129499, 519.0, 528.7277052318057, 6174.475169610583, 6182.28903676078, 6186.814395568134, 6236.469900058501, 6246.0, 5848.590598658096, 5969.3135289441725, 6021.367756385582, 6047.788327408542, 6088.45203931646, 4844.612431005528, 4879.292502587123, 4888.242322440027, 4898.559129678329, 4913.975430122844, 4729.7635118244125, 4841.878953026167, 4850.199717046701, 4932.112219800434, 4944.60443164546, 4798.688085274446, 4806.495317991613, 4859.684120532172, 4861.635377346695, 4871.318015477836, 4806.279058141272, 4811.4707382187935, 4823.372961515016, 4837.879053023703, 4849.806007759686, 4340.739555626673, 4358.280883654225, 4375.409319741826, 4407.779611019436, 4426.889327766831, 5997.340292567814, 6009.369016253274, 6036.909446358308, 6042.788502402439, 6074.635521868702, 5563.638363506399, 5619.943800561983, 5644.068728659766, 5664.688442135681, 5729.398413166599, 6424.807255782334, 6444.258910225337, 6457.709403076873, 6461.256955450136, 6482.416582507597, 4763.595094416979, 4777.522247775195, 4798.808047678089, 4801.231802911552, 4810.0, 6768.458523318172, 6768.898466522957, 6795.524313298071, 6807.217170025411, 6810.353016463428, 4945.876353091129, 4953.03756994403, 4958.553730164231, 4988.825391111366, 4996.625253106032, 4981.850544483599, 5001.549860512571, 5016.824411145592, 5027.698338099725, 5073.188289873602, 5576.749046292926, 5616.297962754656, 5656.660600363992, 5657.717114144276, 5669.206311116447, 6393.520485963571, 6407.807765766941, 6490.707918143695, 6519.5436319457185, 6563.901541476882, 1649.934002639905, 1697.7538256952919, 1705.4883534939718, 1721.510893077479, 1721.8450339469507, 1161.0, 1171.7949358862165, 1209.334865823811, 1210.2738356985737, 1227.2575092069349, 5640.210370548127, 5654.632448890891, 5658.603897727202, 5747.942520574825, 5751.424857514216, 6434.163558737428, 6496.967515162489, 6504.0, 6596.175478065242, 6646.803575356482, 5657.575681823797, 5681.812502186688, 5704.71476426177, 5737.311522617312, 5770.509506691894, 3544.4506101554302, 3550.7217401735356, 3578.284343131384, 3589.94615080774, 3594.5686517618055, 6459.806205813833, 6479.125318082093, 6484.935150648527, 6528.183977002875, 6536.006518012052, 6751.291114432914, 6794.932050679528, 6833.555818871758, 6884.827879302958, 6885.208201056842, 6327.557071005078, 6427.839304017437, 6431.678416079178, 6494.960806271069, 6513.967430163008, 6462.224533056064, 6666.0, 6682.63245521501, 6695.832604184934, 6717.56335838169, 6520.152380190545, 6591.736330546724, 6602.372774586406, 6606.306337834458, 6618.6690665467495, 6326.398992095744, 6374.553781235269, 6440.0, 6481.935180648133, 6515.28331883502, 4857.198562237191, 4886.65793394459, 4916.508349165055, 4919.827806026915, 4928.654994150375, 6646.401823835878, 6654.334566543307, 6658.500612453989, 6695.631740254138, 6785.864282714219, 6273.811785646438, 6475.222973243241, 6478.578892371981, 6519.250286217146, 6540.411362977355, 6340.30256671775, 6430.553125546901, 6433.935660643334, 6452.774152904626, 6458.451031662361, 6092.847678807888, 6214.378562143749, 6225.501959843111, 6323.0, 6325.810225693236, 6304.936950630435, 6344.206974128234, 6387.0, 6438.484921206198, 6493.642849643315, 6187.504999599932, 6240.4071613196675, 6273.466755325666, 6290.842728931813, 6303.338149494237], "value": 4979.749904159432, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.1644886704236, 913.9954300228499, 935.1536859142474, 936.3352020065753, 940.7742141885948, 18114.0, 18983.24067037317, 19059.523511912208, 19104.904475477637, 19195.52011199719, 16527.83472165278, 16921.492355229333, 17043.82956170438, 19529.316473923416, 21473.892630536826, 1038.875334959804, 1066.653337665258, 1066.8933106689308, 1071.036067539213, 1071.5231721883765, 1057.1701214546583, 1057.5029736024057, 1058.1270451877233, 1058.8570542976677, 1062.8458873463344, 1021.7854250607381, 1105.0165352835982, 1115.5036008976008, 1120.8262719278525, 1122.7978963786516, 1109.1736656191108, 1109.4397329348708, 1109.7724966381872, 1110.5335758981248, 1111.4887151910132, 795.085651500773, 799.2007992007992, 799.5122974985254, 799.6521513141744, 802.009518244967, 18692.34576789806, 19231.423057308304, 19301.22795088195, 19455.80544194554, 19831.107600158026, 20026.1989520419, 20457.0, 20647.69028464574, 20774.58450830975, 20814.0, 16352.591185220346, 16362.363763623662, 16394.75407868871, 16499.422520211854, 16564.75152872708, 3563.233904710474, 3572.6605972432835, 3587.246678197582, 3594.6764791168657, 3596.28074385124, 118891.0, 121833.0, 123364.38317808443, 124823.0, 127933.0, 15667.529974100795, 16234.188290585424, 16234.350625975065, 16274.67450651004, 16307.1031093291, 29242.561361579592, 29938.80244790184, 30203.848980755396, 30228.69771302259, 30264.0, 8935.508547029976, 8991.685291014783, 9014.504202268807, 9016.23362014223, 9048.185663290336, 4116.403121547359, 4253.128108737701, 4285.61429471349, 4366.279563871925, 4379.562043795659, 5205.453427390145, 5216.347956505437, 5354.625176237626, 5360.785568577213, 5361.865953351119, 1068.3056013591072, 1069.2087854987253, 1073.7691396349821, 1074.462768615692, 1075.1398880895408, 664.8504086580481, 673.474689742002, 682.4506272450725, 701.2006312803409, 714.8034290570134, 11513.30920144794, 11720.88279117215, 11892.821607675893, 12269.447874845653, 12419.689507762378, 680.843406016609, 684.5755631508497, 707.3492387003969, 714.6141083814786, 717.0069453806516, 5355.973220133952, 5405.135178371442, 5432.456754324615, 5530.917036244459, 5629.662220266715, 104719.0, 108753.45623271832, 109366.0, 112110.0, 113899.0, 93283.0, 95628.52185739166, 98990.5050474743, 100304.0, 102419.0, 85212.0, 85390.57304713437, 85500.57249713836, 87236.0, 88516.0, 10353.792924141626, 10548.525316360628, 10826.837597435888, 10991.670249892515, 12602.747945041232, 35848.4622730654, 36662.8166859164, 37431.25137497289, 38750.80624596859, 38908.41637375498, 68360.0, 70199.0, 71765.28234717586, 78046.6097669508, 79396.60301698455, 19247.615047699248, 19330.8066919329, 19796.80203198007, 19944.401667949984, 19968.201271948958, 21463.57072858565, 21507.677384838928, 21787.564248715255, 22165.889170554045, 22652.433689157904, 19278.13248403853, 19533.60932781308, 19834.60330793347, 20051.49871253172, 20101.49746256355, 18638.440846774618, 19968.77229214364, 20018.29935952293, 20024.098915549126, 20099.497512562302, 17804.287828487235, 18722.71915921235, 19174.61650767005, 19180.232790688216, 19269.80730192736, 13668.52160174389, 13708.108972916729, 14109.0, 14265.42938282457, 14716.337764800395, 13937.58187254384, 14063.085899416505, 14223.857761422667, 14558.636034099232, 14885.553433397015], "value": 9256.078396507526, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 101.0, 108.0, 108.0, 109.0, 110.0, 100.0, 108.0, 117.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 141.0, 186.0, 118.0, 147.0, 151.0, 119.0, 167.0, 118.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 164.0, 163.0, 168.0, 165.0, 163.0, 169.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 179.0, 78.0, 75.0, 74.0, 91.0, 95.0, 76.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 131.0, 78.0, 80.0, 78.0, 127.0, 78.0, 79.0, 121.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 150.0, 150.0, 151.0, 150.0, 161.0, 151.0, 150.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 99.0, 95.0, 97.0, 96.0, 95.0, 94.0, 94.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 62.0, 54.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 79.0, 80.0, 80.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 125.0, 127.0, 133.0, 125.0, 134.0, 132.0, 130.0, 165.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 180.0, 172.0, 175.0, 174.0, 177.0, 181.0, 174.0, 176.0, 176.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 69.0, 68.0, 67.0, 70.0, 66.0, 67.0, 69.0, 66.0], "value": 68.7, "unit": "score"}]}]} 19:09:57 INFO - Return code: 0 19:09:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:09:57 INFO - # TBPL SUCCESS # 19:09:57 INFO - Running post-action listener: _package_coverage_data 19:09:57 INFO - Running post-action listener: _resource_record_post_action 19:09:57 INFO - [mozharness: 2017-07-27 02:09:57.645695Z] Finished run-tests step (success) 19:09:57 INFO - Running post-run listener: _resource_record_post_run 19:09:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 445710336; Read time: 324; Write time: 387972 19:09:57 INFO - TinderboxPrint: CPU usage
13.1% 19:09:57 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 324 19:09:57 INFO - TinderboxPrint: I/O write bytes / time
445,710,336 / 387,972 19:09:57 INFO - TinderboxPrint: CPU idle
8,267.3 (86.8%) 19:09:57 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 19:09:57 INFO - TinderboxPrint: Swap in / out
0 / 0 19:09:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118841344; Read time: 192; Write time: 129288 19:09:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:09:57 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 325746688; Read time: 120; Write time: 258608 19:09:58 INFO - Running post-run listener: _upload_blobber_files 19:09:58 INFO - Blob upload gear active. 19:09:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:09:58 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 19:09:58 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'] 19:09:58 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 19:09:58 INFO - (blobuploader) - INFO - Open directory for files ... 19:09:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:09:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:59 INFO - (blobuploader) - INFO - Done attempting. 19:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:02 INFO - (blobuploader) - INFO - Done attempting. 19:10:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:10:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:10:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:03 INFO - (blobuploader) - INFO - Done attempting. 19:10:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:10:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:10:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:04 INFO - (blobuploader) - INFO - Done attempting. 19:10:04 INFO - (blobuploader) - INFO - Iteration through files over. 19:10:04 INFO - Return code: 0 19:10:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:10:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:10:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba8830f9814d355269fa982f3389b471fad206f2d1c741f12604a4d7575d2aed693361c7203f1f1c854a0151311218493edb6d219bdb16d6aab1c0a071b90fe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f7ee994f68416c71455e408463d2417fa83e01af7c5388a42673137f8dca8da7e723061a3e77c2ac58b1a44ddb62a1669e01c22c6dd80d42ff9db68ebada98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c80788dcc01508ecb6841451e0a983810b0a7f24463fe26ba4a8affe425ef82db333b545f89ff982ca28167a03a8e246e94d3f4dd16538163fe6a7b6d2da35f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71d145af003a744cd7a7ad5a228e982d42cd2dc6a90751f52de9215cb1c42ea919782da995768a5fdceee5ab300d9f0839a85a7d4f0825d4a5b96e41aaa22dad"} 19:10:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:10:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:10:04 INFO - Contents: 19:10:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba8830f9814d355269fa982f3389b471fad206f2d1c741f12604a4d7575d2aed693361c7203f1f1c854a0151311218493edb6d219bdb16d6aab1c0a071b90fe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f7ee994f68416c71455e408463d2417fa83e01af7c5388a42673137f8dca8da7e723061a3e77c2ac58b1a44ddb62a1669e01c22c6dd80d42ff9db68ebada98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c80788dcc01508ecb6841451e0a983810b0a7f24463fe26ba4a8affe425ef82db333b545f89ff982ca28167a03a8e246e94d3f4dd16538163fe6a7b6d2da35f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71d145af003a744cd7a7ad5a228e982d42cd2dc6a90751f52de9215cb1c42ea919782da995768a5fdceee5ab300d9f0839a85a7d4f0825d4a5b96e41aaa22dad"} 19:10:04 INFO - Running post-run listener: copy_logs_to_upload_dir 19:10:04 INFO - Copying logs to upload dir... 19:10:04 INFO - mkdir: /builds/slave/test/build/upload/logs 19:10:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.077988 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-26 19:10:04.227120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 19:10:04.234576) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba8830f9814d355269fa982f3389b471fad206f2d1c741f12604a4d7575d2aed693361c7203f1f1c854a0151311218493edb6d219bdb16d6aab1c0a071b90fe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f7ee994f68416c71455e408463d2417fa83e01af7c5388a42673137f8dca8da7e723061a3e77c2ac58b1a44ddb62a1669e01c22c6dd80d42ff9db68ebada98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c80788dcc01508ecb6841451e0a983810b0a7f24463fe26ba4a8affe425ef82db333b545f89ff982ca28167a03a8e246e94d3f4dd16538163fe6a7b6d2da35f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71d145af003a744cd7a7ad5a228e982d42cd2dc6a90751f52de9215cb1c42ea919782da995768a5fdceee5ab300d9f0839a85a7d4f0825d4a5b96e41aaa22dad"} build_url:https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/SoMb-NCNQqKm-PGrwDTeyQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba8830f9814d355269fa982f3389b471fad206f2d1c741f12604a4d7575d2aed693361c7203f1f1c854a0151311218493edb6d219bdb16d6aab1c0a071b90fe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f7ee994f68416c71455e408463d2417fa83e01af7c5388a42673137f8dca8da7e723061a3e77c2ac58b1a44ddb62a1669e01c22c6dd80d42ff9db68ebada98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c80788dcc01508ecb6841451e0a983810b0a7f24463fe26ba4a8affe425ef82db333b545f89ff982ca28167a03a8e246e94d3f4dd16538163fe6a7b6d2da35f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71d145af003a744cd7a7ad5a228e982d42cd2dc6a90751f52de9215cb1c42ea919782da995768a5fdceee5ab300d9f0839a85a7d4f0825d4a5b96e41aaa22dad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-26 19:10:04.258919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 19:10:04.262329) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1501113112.154713-990904337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-26 19:10:04.345031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 19:10:04.348348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-26 19:10:04.348668) ========= ========= Total master_lag: 0.07 =========