builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1501175783.53 results: success (0) revision: 36f95aeb4c77f7cf3b3366583008cd6e4b6b1dba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:23.528338) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:23.528746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:23.529028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:23.544211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:23.544462) ========= 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=8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 10:16:23-- 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% 50.5M=0s 2017-07-27 10:16:24 (50.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152626 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:23.712901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:23.713221) ========= 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=8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021068 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:23.762170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-27 10:16:23.762455) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 36f95aeb4c77f7cf3b3366583008cd6e4b6b1dba --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 36f95aeb4c77f7cf3b3366583008cd6e4b6b1dba --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=8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 10:16:24,148 truncating revision to first 12 chars 2017-07-27 10:16:24,148 Setting DEBUG logging. 2017-07-27 10:16:24,148 attempt 1/10 2017-07-27 10:16:24,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/36f95aeb4c77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 10:16:25,037 unpacking tar archive at: mozilla-central-36f95aeb4c77/testing/mozharness/ program finished with exit code 0 elapsedTime=1.235118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-27 10:16:25.012583) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:25.015913) ========= script_repo_revision: 36f95aeb4c77f7cf3b3366583008cd6e4b6b1dba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:25.016269) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:25.016524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 10:16:25.026249) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-27 10:16:25.026507) ========= /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=8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:16:25 INFO - MultiFileLogger online at 20170727 10:16:25 in /builds/slave/test 10:16:25 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 10:16:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:16:25 INFO - {'append_to_log': False, 10:16:25 INFO - 'base_work_dir': '/builds/slave/test', 10:16:25 INFO - 'blob_upload_branch': 'Firefox', 10:16:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:16:25 INFO - 'branch': 'Firefox', 10:16:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:16:25 INFO - 'code_coverage': False, 10:16:25 INFO - 'config_files': ('talos/linux_config.py',), 10:16:25 INFO - 'default_actions': ('clobber', 10:16:25 INFO - 'read-buildbot-config', 10:16:25 INFO - 'download-and-extract', 10:16:25 INFO - 'populate-webroot', 10:16:25 INFO - 'create-virtualenv', 10:16:25 INFO - 'install', 10:16:25 INFO - 'setup-mitmproxy', 10:16:25 INFO - 'run-tests'), 10:16:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:16:25 INFO - 'disable_ccov_upload': False, 10:16:25 INFO - 'download_minidump_stackwalk': True, 10:16:25 INFO - 'download_symbols': 'ondemand', 10:16:25 INFO - 'enable_stylo': False, 10:16:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:16:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:16:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:16:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:16:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:16:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:16:25 INFO - 'gecko_profile': False, 10:16:25 INFO - 'gecko_profile_interval': 0, 10:16:25 INFO - 'installer_path': 'installer.exe', 10:16:25 INFO - 'log_level': 'info', 10:16:25 INFO - 'log_name': 'talos', 10:16:25 INFO - 'log_to_console': True, 10:16:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:16:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:16:25 INFO - 'opt_config_files': (), 10:16:25 INFO - 'pip_index': False, 10:16:25 INFO - 'suite': 'dromaeojs-e10s', 10:16:25 INFO - 'system_bits': '32', 10:16:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:16:25 INFO - 'title': 'talos-linux64-ix-038', 10:16:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:16:25 INFO - 'use_talos_json': True, 10:16:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:16:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:16:25 INFO - 'work_dir': 'build'} 10:16:25 INFO - [mozharness: 2017-07-27 17:16:25.518205Z] Running clobber step. 10:16:25 INFO - Running pre-action listener: _resource_record_pre_action 10:16:25 INFO - Running main action method: clobber 10:16:25 INFO - rmtree: /builds/slave/test/build 10:16:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:16:26 INFO - Running post-action listener: _resource_record_post_action 10:16:26 INFO - [mozharness: 2017-07-27 17:16:26.551990Z] Finished clobber step (success) 10:16:26 INFO - [mozharness: 2017-07-27 17:16:26.552094Z] Running read-buildbot-config step. 10:16:26 INFO - Running pre-action listener: _resource_record_pre_action 10:16:26 INFO - Running main action method: read_buildbot_config 10:16:26 INFO - Using buildbot properties: 10:16:26 INFO - { 10:16:26 INFO - "project": "", 10:16:26 INFO - "product": "firefox", 10:16:26 INFO - "who": "archaeopteryx@coole-files.de", 10:16:26 INFO - "installer_path": "public/build/target.tar.bz2", 10:16:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:16:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:16:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:16:26 INFO - "stage_platform": "linux64-stylosequential", 10:16:26 INFO - "basedir": "/builds/slave/test", 10:16:26 INFO - "buildnumber": 124, 10:16:26 INFO - "platform": "ubuntu64_hw_styloseq", 10:16:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:16:26 INFO - "slavebuilddir": "test", 10:16:26 INFO - "taskId": "FMfd8plYQIyJIHTarmXQmg", 10:16:26 INFO - "branch": "mozilla-central", 10:16:26 INFO - "script_repo_revision": "production", 10:16:26 INFO - "revision": "36f95aeb4c77f7cf3b3366583008cd6e4b6b1dba", 10:16:26 INFO - "slavename": "talos-linux64-ix-038", 10:16:26 INFO - "repo_path": "mozilla-central" 10:16:26 INFO - } 10:16:26 INFO - Finding installer, test and symbols from parent task. 10:16:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FMfd8plYQIyJIHTarmXQmg'}, attempt #1 10:16:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FMfd8plYQIyJIHTarmXQmg'}, attempt #1 10:16:27 INFO - Task dependencies: HnoLxSHAT2GalrW-E1tmuA 10:16:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA'}, attempt #1 10:16:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.tar.bz2 10:16:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/test_packages.json 10:16:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.crashreporter-symbols.zip 10:16:27 INFO - Running post-action listener: _resource_record_post_action 10:16:27 INFO - [mozharness: 2017-07-27 17:16:27.975841Z] Finished read-buildbot-config step (success) 10:16:27 INFO - [mozharness: 2017-07-27 17:16:27.976063Z] Running download-and-extract step. 10:16:27 INFO - Running pre-action listener: _resource_record_pre_action 10:16:27 INFO - Running main action method: download_and_extract 10:16:27 INFO - mkdir: /builds/slave/test/build/tests 10:16:27 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')]} 10:16:27 INFO - trying https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.test_packages.json 10:16:27 INFO - Downloading https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:16:28 INFO - Downloaded 989 bytes. 10:16:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:16:28 INFO - Using the following test package requirements: 10:16:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:16:28 INFO - u'common': [u'target.common.tests.zip'], 10:16:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:16:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:16:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:16:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:16:28 INFO - u'mozbase': [u'target.common.tests.zip'], 10:16:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:16:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:16:28 INFO - u'web-platform': [u'target.common.tests.zip', 10:16:28 INFO - u'target.web-platform.tests.tar.gz'], 10:16:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:16:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:16:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.common.tests.zip 10:16:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:16:28 INFO - Fetch https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.common.tests.zip into memory 10:16:29 INFO - Content-Length response header: 72550425 10:16:29 INFO - Bytes received: 72550425 10:16:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:16:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.common.tests.zip 10:16:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:16:41 INFO - Fetch https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.common.tests.zip into memory 10:16:42 INFO - Content-Length response header: 72550425 10:16:42 INFO - Bytes received: 72550425 10:16:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.talos.tests.zip 10:16:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:16:54 INFO - Fetch https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.talos.tests.zip into memory 10:16:55 INFO - Content-Length response header: 14496465 10:16:55 INFO - Bytes received: 14496465 10:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:56 INFO - trying https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.tar.bz2 10:16:56 INFO - Downloading https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:16:57 INFO - Downloaded 62149275 bytes. 10:16:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.tar.bz2 10:16:57 INFO - mkdir: /builds/slave/test/properties 10:16:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:16:57 INFO - Writing to file /builds/slave/test/properties/build_url 10:16:57 INFO - Contents: 10:16:57 INFO - build_url:https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.tar.bz2 10:16:57 INFO - Running post-action listener: _resource_record_post_action 10:16:57 INFO - Running post-action listener: set_extra_try_arguments 10:16:57 INFO - [mozharness: 2017-07-27 17:16:57.125530Z] Finished download-and-extract step (success) 10:16:57 INFO - [mozharness: 2017-07-27 17:16:57.125630Z] Running populate-webroot step. 10:16:57 INFO - Running pre-action listener: _resource_record_pre_action 10:16:57 INFO - Running main action method: populate_webroot 10:16:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:16:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:16:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:16:57 INFO - 'tests': ['damp', 'tps']}, 10:16:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:16:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:16:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:16:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:16:57 INFO - 'other-e10s': {'tests': ['a11yr', 10:16:57 INFO - 'ts_paint', 10:16:57 INFO - 'tpaint', 10:16:57 INFO - 'sessionrestore', 10:16:57 INFO - 'sessionrestore_many_windows', 10:16:57 INFO - 'sessionrestore_no_auto_restore', 10:16:57 INFO - 'tabpaint']}, 10:16:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:16:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:16:57 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:16:57 INFO - 'talos_options': ['--mitmproxy', 10:16:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:16:57 INFO - '--firstNonBlankPaint'], 10:16:57 INFO - 'tests': ['quantum_pageload_google', 10:16:57 INFO - 'quantum_pageload_youtube', 10:16:57 INFO - 'quantum_pageload_amazon', 10:16:57 INFO - 'quantum_pageload_facebook']}, 10:16:57 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:16:57 INFO - 'talos_options': ['--stylo', 10:16:57 INFO - '--mitmproxy', 10:16:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:16:57 INFO - '--firstNonBlankPaint'], 10:16:57 INFO - 'tests': ['quantum_pageload_google', 10:16:57 INFO - 'quantum_pageload_youtube', 10:16:57 INFO - 'quantum_pageload_amazon', 10:16:57 INFO - 'quantum_pageload_facebook']}, 10:16:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:16:57 INFO - 'tsvgr_opacity', 10:16:57 INFO - 'tart', 10:16:57 INFO - 'tscrollx', 10:16:57 INFO - 'cart', 10:16:57 INFO - 'tsvg_static']}, 10:16:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:16:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:16:57 INFO - 'talos_options': ['--xperf_path', 10:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:57 INFO - 'tests': ['tp5n']}}} 10:16:57 INFO - Running post-action listener: _resource_record_post_action 10:16:57 INFO - [mozharness: 2017-07-27 17:16:57.132958Z] Finished populate-webroot step (success) 10:16:57 INFO - [mozharness: 2017-07-27 17:16:57.133049Z] Running create-virtualenv step. 10:16:57 INFO - Running pre-action listener: _resource_record_pre_action 10:16:57 INFO - Running main action method: create_virtualenv 10:16:57 INFO - Creating virtualenv /builds/slave/test/build/venv 10:16:57 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 10:16:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:16:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:16:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:16:57 INFO - Using real prefix '/usr' 10:16:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:16:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:16:59 INFO - Installing pip.................done. 10:16:59 INFO - Return code: 0 10:16:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:16:59 INFO - Reading from file tmpfile_stdout 10:16:59 INFO - Output received: 10:16:59 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) 10:16:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:59 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:16:59 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 10:16:59 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 10:16:59 INFO - Using env: {'DISPLAY': ':0', 10:16:59 INFO - 'HOME': '/home/cltbld', 10:16:59 INFO - 'LANG': 'en_US.UTF-8', 10:16:59 INFO - 'LANGUAGE': 'en_US:en', 10:16:59 INFO - 'LOGNAME': 'cltbld', 10:16:59 INFO - 'MAIL': '/var/mail/cltbld', 10:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:59 INFO - 'MOZ_NO_REMOTE': '1', 10:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:59 INFO - 'NO_EM_RESTART': '1', 10:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:59 INFO - 'PWD': '/builds/slave/test', 10:16:59 INFO - 'SHELL': '/bin/bash', 10:16:59 INFO - 'SHLVL': '1', 10:16:59 INFO - 'TERM': 'linux', 10:16:59 INFO - 'TMOUT': '86400', 10:16:59 INFO - 'USER': 'cltbld', 10:16:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:59 INFO - '_': '/tools/buildbot/bin/python'} 10:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:00 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 10:17:00 INFO - Cleaning up... 10:17:00 INFO - Return code: 0 10:17:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:00 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17:00 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 10:17:00 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 10:17:00 INFO - Using env: {'DISPLAY': ':0', 10:17:00 INFO - 'HOME': '/home/cltbld', 10:17:00 INFO - 'LANG': 'en_US.UTF-8', 10:17:00 INFO - 'LANGUAGE': 'en_US:en', 10:17:00 INFO - 'LOGNAME': 'cltbld', 10:17:00 INFO - 'MAIL': '/var/mail/cltbld', 10:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:00 INFO - 'MOZ_NO_REMOTE': '1', 10:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:00 INFO - 'NO_EM_RESTART': '1', 10:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:00 INFO - 'PWD': '/builds/slave/test', 10:17:00 INFO - 'SHELL': '/bin/bash', 10:17:00 INFO - 'SHLVL': '1', 10:17:00 INFO - 'TERM': 'linux', 10:17:00 INFO - 'TMOUT': '86400', 10:17:00 INFO - 'USER': 'cltbld', 10:17:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:00 INFO - '_': '/tools/buildbot/bin/python'} 10:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:00 INFO - Downloading/unpacking psutil>=3.1.1 10:17: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 10:17: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 10:17: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 10:17: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 10:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:01 INFO - Installing collected packages: psutil 10:17:01 INFO - Running setup.py install for psutil 10:17:01 INFO - building 'psutil._psutil_linux' extension 10:17:01 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 10:17:01 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 10:17:01 INFO - building 'psutil._psutil_posix' extension 10:17:01 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 10:17:01 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 10:17:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:02 INFO - Successfully installed psutil 10:17:02 INFO - Cleaning up... 10:17:02 INFO - Return code: 0 10:17:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:02 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17:02 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 10:17:02 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 10:17:02 INFO - Using env: {'DISPLAY': ':0', 10:17:02 INFO - 'HOME': '/home/cltbld', 10:17:02 INFO - 'LANG': 'en_US.UTF-8', 10:17:02 INFO - 'LANGUAGE': 'en_US:en', 10:17:02 INFO - 'LOGNAME': 'cltbld', 10:17:02 INFO - 'MAIL': '/var/mail/cltbld', 10:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:02 INFO - 'MOZ_NO_REMOTE': '1', 10:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:02 INFO - 'NO_EM_RESTART': '1', 10:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:02 INFO - 'PWD': '/builds/slave/test', 10:17:02 INFO - 'SHELL': '/bin/bash', 10:17:02 INFO - 'SHLVL': '1', 10:17:02 INFO - 'TERM': 'linux', 10:17:02 INFO - 'TMOUT': '86400', 10:17:02 INFO - 'USER': 'cltbld', 10:17:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:02 INFO - '_': '/tools/buildbot/bin/python'} 10:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:17:02 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 10:17:02 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 10:17:02 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 10:17:02 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 10:17:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:17:03 INFO - Installing collected packages: mozsystemmonitor 10:17:03 INFO - Running setup.py install for mozsystemmonitor 10:17:03 INFO - Successfully installed mozsystemmonitor 10:17:03 INFO - Cleaning up... 10:17:03 INFO - Return code: 0 10:17:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17: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==2.5.1'] in /builds/slave/test/build 10:17: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==2.5.1 10:17:03 INFO - Using env: {'DISPLAY': ':0', 10:17:03 INFO - 'HOME': '/home/cltbld', 10:17:03 INFO - 'LANG': 'en_US.UTF-8', 10:17:03 INFO - 'LANGUAGE': 'en_US:en', 10:17:03 INFO - 'LOGNAME': 'cltbld', 10:17:03 INFO - 'MAIL': '/var/mail/cltbld', 10:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:03 INFO - 'MOZ_NO_REMOTE': '1', 10:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:03 INFO - 'NO_EM_RESTART': '1', 10:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:03 INFO - 'PWD': '/builds/slave/test', 10:17:03 INFO - 'SHELL': '/bin/bash', 10:17:03 INFO - 'SHLVL': '1', 10:17:03 INFO - 'TERM': 'linux', 10:17:03 INFO - 'TMOUT': '86400', 10:17:03 INFO - 'USER': 'cltbld', 10:17:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:03 INFO - '_': '/tools/buildbot/bin/python'} 10:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:03 INFO - Downloading/unpacking jsonschema==2.5.1 10:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:17:04 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 10:17:04 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 10:17:04 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 10:17:04 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 10:17:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:05 INFO - warning: no files found matching '*.txt' 10:17:05 INFO - no previously-included directories found matching 'build' 10:17:05 INFO - no previously-included directories found matching 'dist' 10:17:05 INFO - no previously-included directories found matching '.git*' 10:17:05 INFO - Installing collected packages: jsonschema, functools32 10:17:05 INFO - Running setup.py install for functools32 10:17:05 INFO - warning: no files found matching '*.txt' 10:17:05 INFO - no previously-included directories found matching 'build' 10:17:05 INFO - no previously-included directories found matching 'dist' 10:17:05 INFO - no previously-included directories found matching '.git*' 10:17:05 INFO - Successfully installed jsonschema functools32 10:17:05 INFO - Cleaning up... 10:17:05 INFO - Return code: 0 10:17:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:05 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17:05 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 10:17:05 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 10:17:05 INFO - Using env: {'DISPLAY': ':0', 10:17:05 INFO - 'HOME': '/home/cltbld', 10:17:05 INFO - 'LANG': 'en_US.UTF-8', 10:17:05 INFO - 'LANGUAGE': 'en_US:en', 10:17:05 INFO - 'LOGNAME': 'cltbld', 10:17:05 INFO - 'MAIL': '/var/mail/cltbld', 10:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:05 INFO - 'MOZ_NO_REMOTE': '1', 10:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:05 INFO - 'NO_EM_RESTART': '1', 10:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:05 INFO - 'PWD': '/builds/slave/test', 10:17:05 INFO - 'SHELL': '/bin/bash', 10:17:05 INFO - 'SHLVL': '1', 10:17:05 INFO - 'TERM': 'linux', 10:17:05 INFO - 'TMOUT': '86400', 10:17:05 INFO - 'USER': 'cltbld', 10:17:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:05 INFO - '_': '/tools/buildbot/bin/python'} 10:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:17:05 INFO - Cleaning up... 10:17:05 INFO - Return code: 0 10:17:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:05 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17:05 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 10:17:05 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 10:17:05 INFO - Using env: {'DISPLAY': ':0', 10:17:05 INFO - 'HOME': '/home/cltbld', 10:17:05 INFO - 'LANG': 'en_US.UTF-8', 10:17:05 INFO - 'LANGUAGE': 'en_US:en', 10:17:05 INFO - 'LOGNAME': 'cltbld', 10:17:05 INFO - 'MAIL': '/var/mail/cltbld', 10:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:05 INFO - 'MOZ_NO_REMOTE': '1', 10:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:05 INFO - 'NO_EM_RESTART': '1', 10:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:05 INFO - 'PWD': '/builds/slave/test', 10:17:05 INFO - 'SHELL': '/bin/bash', 10:17:05 INFO - 'SHLVL': '1', 10:17:05 INFO - 'TERM': 'linux', 10:17:05 INFO - 'TMOUT': '86400', 10:17:05 INFO - 'USER': 'cltbld', 10:17:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:05 INFO - '_': '/tools/buildbot/bin/python'} 10:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:05 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:07 INFO - Downloading docopt-0.6.1.tar.gz 10:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:07 INFO - Running setup.py install for blobuploader 10:17:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:07 INFO - Running setup.py install for requests 10:17:07 INFO - Running setup.py install for docopt 10:17:08 INFO - Successfully installed blobuploader requests docopt 10:17:08 INFO - Cleaning up... 10:17:08 INFO - Return code: 0 10:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:08 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17:08 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 10:17:08 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 10:17:08 INFO - Using env: {'DISPLAY': ':0', 10:17:08 INFO - 'HOME': '/home/cltbld', 10:17:08 INFO - 'LANG': 'en_US.UTF-8', 10:17:08 INFO - 'LANGUAGE': 'en_US:en', 10:17:08 INFO - 'LOGNAME': 'cltbld', 10:17:08 INFO - 'MAIL': '/var/mail/cltbld', 10:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:08 INFO - 'MOZ_NO_REMOTE': '1', 10:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:08 INFO - 'NO_EM_RESTART': '1', 10:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:08 INFO - 'PWD': '/builds/slave/test', 10:17:08 INFO - 'SHELL': '/bin/bash', 10:17:08 INFO - 'SHLVL': '1', 10:17:08 INFO - 'TERM': 'linux', 10:17:08 INFO - 'TMOUT': '86400', 10:17:08 INFO - 'USER': 'cltbld', 10:17:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:08 INFO - '_': '/tools/buildbot/bin/python'} 10:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:08 INFO - Running setup.py (path:/tmp/pip-X_YEOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:08 INFO - Running setup.py (path:/tmp/pip-SnjNtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:08 INFO - Running setup.py (path:/tmp/pip-wImcx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:08 INFO - Running setup.py (path:/tmp/pip-T8HNBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:08 INFO - Running setup.py (path:/tmp/pip-BmM8Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:08 INFO - Running setup.py (path:/tmp/pip-W9SBoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:08 INFO - Running setup.py (path:/tmp/pip-JvLNd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:08 INFO - Running setup.py (path:/tmp/pip-Ycm5Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:08 INFO - Running setup.py (path:/tmp/pip-9daj_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:08 INFO - Running setup.py (path:/tmp/pip-CJNQGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:09 INFO - Running setup.py (path:/tmp/pip-kxEMTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:09 INFO - Running setup.py (path:/tmp/pip-CCEviJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:09 INFO - Running setup.py (path:/tmp/pip-cdtxt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:09 INFO - Running setup.py (path:/tmp/pip-8atbUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:09 INFO - Running setup.py (path:/tmp/pip-Wgym0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:09 INFO - Running setup.py (path:/tmp/pip-2YHTHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:09 INFO - Running setup.py (path:/tmp/pip-tvYeOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:09 INFO - Running setup.py install for manifestparser 10:17:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:09 INFO - Running setup.py install for mozcrash 10:17:09 INFO - Running setup.py install for mozdebug 10:17:09 INFO - Running setup.py install for mozdevice 10:17:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:09 INFO - Running setup.py install for mozfile 10:17:10 INFO - Running setup.py install for mozhttpd 10:17:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Running setup.py install for mozinfo 10:17:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Running setup.py install for mozInstall 10:17:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Running setup.py install for mozleak 10:17:10 INFO - Running setup.py install for mozlog 10:17:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Running setup.py install for moznetwork 10:17:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Running setup.py install for mozprocess 10:17:10 INFO - Running setup.py install for mozprofile 10:17:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Running setup.py install for mozrunner 10:17:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Running setup.py install for mozscreenshot 10:17:11 INFO - Running setup.py install for moztest 10:17:11 INFO - Running setup.py install for mozversion 10:17:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:11 INFO - Cleaning up... 10:17:11 INFO - Return code: 0 10:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:11 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')]} 10:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:11 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')]} 10:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:11 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17:11 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 10:17:11 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 10:17:11 INFO - Using env: {'DISPLAY': ':0', 10:17:11 INFO - 'HOME': '/home/cltbld', 10:17:11 INFO - 'LANG': 'en_US.UTF-8', 10:17:11 INFO - 'LANGUAGE': 'en_US:en', 10:17:11 INFO - 'LOGNAME': 'cltbld', 10:17:11 INFO - 'MAIL': '/var/mail/cltbld', 10:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:11 INFO - 'MOZ_NO_REMOTE': '1', 10:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:11 INFO - 'NO_EM_RESTART': '1', 10:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:11 INFO - 'PWD': '/builds/slave/test', 10:17:11 INFO - 'SHELL': '/bin/bash', 10:17:11 INFO - 'SHLVL': '1', 10:17:11 INFO - 'TERM': 'linux', 10:17:11 INFO - 'TMOUT': '86400', 10:17:11 INFO - 'USER': 'cltbld', 10:17:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:11 INFO - '_': '/tools/buildbot/bin/python'} 10:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:11 INFO - Running setup.py (path:/tmp/pip-ZIXIIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:11 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)) 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:11 INFO - Running setup.py (path:/tmp/pip-UCrGn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:11 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)) 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:11 INFO - Running setup.py (path:/tmp/pip-iZoKhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:11 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)) 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:11 INFO - Running setup.py (path:/tmp/pip-Jxi2tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:11 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)) 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:11 INFO - Running setup.py (path:/tmp/pip-J21ofY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:11 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)) 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:11 INFO - Running setup.py (path:/tmp/pip-Fwd1vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:12 INFO - Running setup.py (path:/tmp/pip-_B8vVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:12 INFO - Running setup.py (path:/tmp/pip-rKd2XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:12 INFO - Running setup.py (path:/tmp/pip-BkDGsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:12 INFO - Running setup.py (path:/tmp/pip-l5SEzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:12 INFO - Running setup.py (path:/tmp/pip-lEPkY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:12 INFO - Running setup.py (path:/tmp/pip-3crnnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:12 INFO - Running setup.py (path:/tmp/pip-cQw_m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:12 INFO - Running setup.py (path:/tmp/pip-pe9Uo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:12 INFO - Running setup.py (path:/tmp/pip-g4cOey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:12 INFO - Running setup.py (path:/tmp/pip-E_lloV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:12 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)) 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:12 INFO - Running setup.py (path:/tmp/pip-XaBp0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:12 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)) 10:17:12 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)) 10:17:12 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)) 10:17:12 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)) 10:17:12 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)) 10:17:12 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)) 10:17:12 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)) 10:17:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:12 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 10:17:12 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 10:17:12 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 10:17:12 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 10:17:13 INFO - Downloading blessings-1.6.tar.gz 10:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:13 INFO - Installing collected packages: blessings 10:17:13 INFO - Running setup.py install for blessings 10:17:14 INFO - Successfully installed blessings 10:17:14 INFO - Cleaning up... 10:17:14 INFO - Return code: 0 10:17:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:14 INFO - Reading from file tmpfile_stdout 10:17:14 INFO - Current package versions: 10:17:14 INFO - argparse == 1.2.1 10:17:14 INFO - blessings == 1.6 10:17:14 INFO - blobuploader == 1.2.4 10:17:14 INFO - docopt == 0.6.1 10:17:14 INFO - functools32 == 3.2.3-2 10:17:14 INFO - jsonschema == 2.5.1 10:17:14 INFO - manifestparser == 1.1 10:17:14 INFO - mozInstall == 1.13 10:17:14 INFO - mozcrash == 1.0 10:17:14 INFO - mozdebug == 0.1 10:17:14 INFO - mozdevice == 0.51 10:17:14 INFO - mozfile == 1.2 10:17:14 INFO - mozhttpd == 0.7 10:17:14 INFO - mozinfo == 0.10 10:17:14 INFO - mozleak == 0.1 10:17:14 INFO - mozlog == 3.5 10:17:14 INFO - moznetwork == 0.27 10:17:14 INFO - mozprocess == 0.25 10:17:14 INFO - mozprofile == 0.28 10:17:14 INFO - mozrunner == 6.13 10:17:14 INFO - mozscreenshot == 0.1 10:17:14 INFO - mozsystemmonitor == 0.3 10:17:14 INFO - moztest == 0.8 10:17:14 INFO - mozversion == 1.4 10:17:14 INFO - psutil == 3.1.1 10:17:14 INFO - requests == 1.2.3 10:17:14 INFO - wsgiref == 0.1.2 10:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:14 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')]} 10:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:14 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')]} 10:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:14 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17:14 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 10:17:14 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 10:17:14 INFO - Using env: {'DISPLAY': ':0', 10:17:14 INFO - 'HOME': '/home/cltbld', 10:17:14 INFO - 'LANG': 'en_US.UTF-8', 10:17:14 INFO - 'LANGUAGE': 'en_US:en', 10:17:14 INFO - 'LOGNAME': 'cltbld', 10:17:14 INFO - 'MAIL': '/var/mail/cltbld', 10:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:14 INFO - 'MOZ_NO_REMOTE': '1', 10:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:14 INFO - 'NO_EM_RESTART': '1', 10:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:14 INFO - 'PWD': '/builds/slave/test', 10:17:14 INFO - 'SHELL': '/bin/bash', 10:17:14 INFO - 'SHLVL': '1', 10:17:14 INFO - 'TERM': 'linux', 10:17:14 INFO - 'TMOUT': '86400', 10:17:14 INFO - 'USER': 'cltbld', 10:17:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:14 INFO - '_': '/tools/buildbot/bin/python'} 10:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:14 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)) 10:17:14 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)) 10:17:14 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)) 10:17:14 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)) 10:17:14 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)) 10:17:14 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)) 10:17:14 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)) 10:17:14 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)) 10:17:14 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)) 10:17:14 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:17:14 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 10:17:14 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 10:17:14 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 10:17:14 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 10:17:15 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:17:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 10:17:15 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 10:17:15 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 10:17:15 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 10:17:15 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 10:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:17:15 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)) 10:17:15 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)) 10:17:15 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)) 10:17:15 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)) 10:17:15 INFO - Installing collected packages: marionette-driver, simplejson 10:17:15 INFO - Running setup.py install for marionette-driver 10:17:16 INFO - Running setup.py install for simplejson 10:17:16 INFO - building 'simplejson._speedups' extension 10:17:16 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 10:17:16 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 10:17:17 INFO - Successfully installed marionette-driver simplejson 10:17:17 INFO - Cleaning up... 10:17:17 INFO - Return code: 0 10:17:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17:17 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')]} 10:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:17 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')]} 10:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:17 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 0x1c511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, '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': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', '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 10:17:17 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 10:17:17 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 10:17:17 INFO - Using env: {'DISPLAY': ':0', 10:17:17 INFO - 'HOME': '/home/cltbld', 10:17:17 INFO - 'LANG': 'en_US.UTF-8', 10:17:17 INFO - 'LANGUAGE': 'en_US:en', 10:17:17 INFO - 'LOGNAME': 'cltbld', 10:17:17 INFO - 'MAIL': '/var/mail/cltbld', 10:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:17 INFO - 'MOZ_NO_REMOTE': '1', 10:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:17 INFO - 'NO_EM_RESTART': '1', 10:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:17 INFO - 'PWD': '/builds/slave/test', 10:17:17 INFO - 'SHELL': '/bin/bash', 10:17:17 INFO - 'SHLVL': '1', 10:17:17 INFO - 'TERM': 'linux', 10:17:17 INFO - 'TMOUT': '86400', 10:17:17 INFO - 'USER': 'cltbld', 10:17:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:17 INFO - '_': '/tools/buildbot/bin/python'} 10:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:17:17 INFO - Cleaning up... 10:17:17 INFO - Return code: 0 10:17:17 INFO - Running post-action listener: _resource_record_post_action 10:17:17 INFO - Running post-action listener: _start_resource_monitoring 10:17:17 INFO - Starting resource monitoring. 10:17:17 INFO - [mozharness: 2017-07-27 17:17:17.418003Z] Finished create-virtualenv step (success) 10:17:17 INFO - [mozharness: 2017-07-27 17:17:17.418511Z] Running install step. 10:17:17 INFO - Running pre-action listener: _resource_record_pre_action 10:17:17 INFO - Running main action method: install 10:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:17 INFO - Reading from file tmpfile_stdout 10:17:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:17 INFO - Reading from file tmpfile_stdout 10:17:17 INFO - Output received: 10:17:17 INFO - Usage: mozinstall [options] installer 10:17:17 INFO - Options: 10:17:17 INFO - -h, --help show this help message and exit 10:17:17 INFO - -d DEST, --destination=DEST 10:17:17 INFO - Directory to install application into. [default: 10:17:17 INFO - "/builds/slave/test"] 10:17:17 INFO - --app=APP Application being installed. [default: firefox] 10:17:17 INFO - mkdir: /builds/slave/test/build/application 10:17:17 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'] 10:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:17:35 INFO - Reading from file tmpfile_stdout 10:17:35 INFO - Output received: 10:17:35 INFO - /builds/slave/test/build/application/firefox/firefox 10:17:35 INFO - Running post-action listener: _resource_record_post_action 10:17:35 INFO - [mozharness: 2017-07-27 17:17:35.811319Z] Finished install step (success) 10:17:35 INFO - [mozharness: 2017-07-27 17:17:35.811574Z] Running setup-mitmproxy step. 10:17:35 INFO - Running pre-action listener: _resource_record_pre_action 10:17:35 INFO - Running main action method: setup_mitmproxy 10:17:35 INFO - Skipping: mitmproxy is not required 10:17:35 INFO - Running post-action listener: _resource_record_post_action 10:17:35 INFO - [mozharness: 2017-07-27 17:17:35.812708Z] Finished setup-mitmproxy step (success) 10:17:35 INFO - [mozharness: 2017-07-27 17:17:35.812930Z] Running run-tests step. 10:17:35 INFO - Running pre-action listener: _resource_record_pre_action 10:17:35 INFO - Running pre-action listener: _set_gcov_prefix 10:17:35 INFO - Running main action method: run_tests 10:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:17:35 INFO - Python 2.7.3 10:17:35 INFO - Return code: 0 10:17:35 INFO - grabbing minidump binary from tooltool 10:17:35 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')]} 10:17:35 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 0x1fbdeb0>, '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 0x1fbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:17:35 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 10:17:35 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 10:17:35 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 10:17:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:17:35 INFO - Return code: 0 10:17:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:17:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:17:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:17:35 INFO - ENV: RUST_BACKTRACE is now 1 10:17:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:17:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:17:35 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/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:17:35 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/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 10:17:35 INFO - Using env: {'DISPLAY': ':0', 10:17:35 INFO - 'HOME': '/home/cltbld', 10:17:35 INFO - 'LANG': 'en_US.UTF-8', 10:17:35 INFO - 'LANGUAGE': 'en_US:en', 10:17:35 INFO - 'LOGNAME': 'cltbld', 10:17:35 INFO - 'MAIL': '/var/mail/cltbld', 10:17:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:17:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:35 INFO - 'MOZ_NO_REMOTE': '1', 10:17:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:35 INFO - 'NO_EM_RESTART': '1', 10:17:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:35 INFO - 'PWD': '/builds/slave/test', 10:17:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:17:35 INFO - 'RUST_BACKTRACE': '1', 10:17:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:17:35 INFO - 'SHELL': '/bin/bash', 10:17:35 INFO - 'SHLVL': '1', 10:17:35 INFO - 'STYLO_FORCE_ENABLED': '1', 10:17:35 INFO - 'TERM': 'linux', 10:17:35 INFO - 'TMOUT': '86400', 10:17:35 INFO - 'USER': 'cltbld', 10:17:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167', 10:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:35 INFO - '_': '/tools/buildbot/bin/python'} 10:17:35 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/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:17:36 INFO - mozversion application_buildid: 20170727161733 10:17:36 INFO - mozversion application_changeset: 36f95aeb4c77f7cf3b3366583008cd6e4b6b1dba 10:17:36 INFO - mozversion application_display_name: Nightly 10:17:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:17:36 INFO - mozversion application_name: Firefox 10:17:36 INFO - mozversion application_remotingname: firefox 10:17:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:17:36 INFO - mozversion application_vendor: Mozilla 10:17:36 INFO - mozversion application_version: 56.0a1 10:17:36 INFO - mozversion platform_buildid: 20170727161733 10:17:36 INFO - mozversion platform_changeset: 36f95aeb4c77f7cf3b3366583008cd6e4b6b1dba 10:17:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:17:36 INFO - mozversion platform_version: 56.0a1 10:17:36 INFO - using testdate: 1501175856 10:17:36 INFO - actual date: 1501175856 10:17:36 INFO - starting webserver on 'localhost:39099' 10:17:36 INFO - SUITE-START | Running 2 tests 10:17:36 INFO - TEST-START | dromaeo_css 10:17:36 INFO - Initialising browser for dromaeo_css test... 10:17:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39099/getInfo.html -profile /tmp/tmpMkXNHt/profile 10:17:36 INFO - TEST-INFO | started process 25746 (/builds/slave/test/build/application/firefox/firefox http://localhost:39099/getInfo.html) 10:17:43 INFO - TEST-INFO | 25746: exit 0 10:17:43 INFO - Browser initialized. 10:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:17:43 INFO - TEST-INFO | started process 25973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkXNHt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:44 INFO - PID 25973 | 10:17:44 INFO - PID 25973 | (/builds/slave/test/build/application/firefox/firefox:26027): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:17:44 INFO - PID 25973 | 10:17:54 INFO - PID 25973 | RSS: Main: 173342720 10:17:54 INFO - PID 25973 | 10:20:53 INFO - PID 25973 | Cycle 1(1): loaded http://localhost:39099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39099/tests/dromaeo/cssquery-ext.html) 10:20:55 INFO - PID 25973 | RSS: Main: 175374336 10:20:55 INFO - PID 25973 | 10:23:56 INFO - PID 25973 | Cycle 1(1): loaded http://localhost:39099/tests/dromaeo/cssquery-ext.html (next: http://localhost:39099/tests/dromaeo/cssquery-jquery.html) 10:23:57 INFO - PID 25973 | RSS: Main: 172986368 10:23:57 INFO - PID 25973 | 10:26:59 INFO - PID 25973 | Cycle 1(1): loaded http://localhost:39099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39099/tests/dromaeo/cssquery-mootools.html) 10:27:00 INFO - PID 25973 | RSS: Main: 173088768 10:27:00 INFO - PID 25973 | 10:30:01 INFO - PID 25973 | Cycle 1(1): loaded http://localhost:39099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39099/tests/dromaeo/cssquery-prototype.html) 10:30:02 INFO - PID 25973 | RSS: Main: 173109248 10:30:02 INFO - PID 25973 | 10:33:06 INFO - PID 25973 | Cycle 1(1): loaded http://localhost:39099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39099/tests/dromaeo/cssquery-yui.html) 10:33:07 INFO - PID 25973 | RSS: Main: 174981120 10:33:07 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | Cycle 1(1): loaded http://localhost:39099/tests/dromaeo/cssquery-yui.html (next: http://localhost:39099/tests/dromaeo/cssquery-dojo.html) 10:36:09 INFO - PID 25973 | RSS: Main: 175902720 10:36:09 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | __start_tp_report 10:36:09 INFO - PID 25973 | _x_x_mozilla_page_load 10:36:09 INFO - PID 25973 | _x_x_mozilla_page_load_details 10:36:09 INFO - PID 25973 | |i|pagename|runs| 10:36:09 INFO - PID 25973 | |0;dojo.html;3144.0253521408367;3160.0993716790713;3184.1721152500345;3189.840507974601;3198.200449887528;6082.422169893853;6206.6586337751405;6229.968850155748;6243.594166379182;6258.874822503547;6188.257409110913;6231.096491008812;6240.126382306481;6243.406876346739;6250.249970003594;5664.1220610805185;5700.600957932947;5713.628614140089;5732.0828667413225;5788.884222315552;5759.539236861041;5775.855603609902;5778.133280008012;5785.421457854202;5821.592488525805;132.05536431902783;5630.971845140789;5667.518260947824;5799.73901174446;5810.418958104176;5239.1355426354985;5624.3250809902665;5627.662340259598;5727.971360143214;5735;5627.943720562783;5644.915326270109;5691.8292451226525;5710.14347847822;5715.5427565794635;6124.785632502841;6134.662593557353;6152.938470615326;6189.9381006189815;6212.4408803207925;6610.305917878602;6613.2064152301555;6702.530822842403;6713.328667133296;6724.226713927912;6609.140811694497;6682.866342673119;6692.799216023527;6805.455563554904;6806.421454176401;6192.659403732793;6217.502599792006;6219.40915613016;6220.502359811204;6226.813195604139;6775.1531058617675;6876.518643694893;6886.139232595926;6887.862242755117;6892.517523773388;6537.967310163419;6560.212774467094;6560.40956313934;6573.375529324802;6574.9671251644395;6595.0766892635065;6641.900371494431;6652.334766523309;6655.767048153388;6734.6632668367365;6557.967210163919;6585.736570537125;6620.569662971891;6691.7323307068145;6728.192616885907;6545.247296560957;6604.537682362285;6645.169353830771;6691.631960242136;6711.094002309724;5367.141257398797;5384.811531596453;5412.56699464042;5419.051665958442;5426.9185962210595;4637.5130611286;4639.280911458729;4695.835645752382;4714.316424118552;4738.857834264978;5763.308402991668;5775.16260142277;5844.912326315109;5852.15143804146;5857.47282744555;6553.082568440422;6664.7000884959325;6687.899681504781;6745.527813053137;6760.628165450849;5785.10330898703;5847.532197424196;5864.354920958691;5868.471837534557;5876.500497457764;5917.970410148007;5952.5833191676165;5954.315253745788;5960.880782384328;5965.105234214816;6487.416132548094;6570.507211959122;6587.50593705474;6589.7364105435245;6600.735970561123;6677.165354330708;6743.527953043338;6757.729690812509;6759.594424334556;6781.525293229427;6459.935400646122;6499.545031847725;6551.115599394021;6556.311587283267;6564.573302735307;6441.967790161019;6544.8363790905605;6546.967265163644;6554.115194448688;6662.400383965466;6754.662266886734;6781.11845460087;6784;6786.253512113763;6789.62657053847;6494.058361537456;6541.08424820516;6544.8363790905605;6583.210014798255;6588.143541339787;6445.097686324012;6462.3537646235;6550.377714117151;6551.44312733423;6578.177727784027;6380.106785050004;6459.128017717548;6460.030995350735;6472.514561407819;6478.935210647834;6500.804975850732;6520.119783829123;6571.704273307617;6585.242697089896;6594.538382313192;6201.2868520118955;6296.716647750954;6334.081558174131;6345.524085693499;6350.936490635035 10:36:09 INFO - PID 25973 | |1;ext.html;747.5925620536807;823.7487566292282;843.3632607381426;854.9572521373926;1163.2729544034978;30375;30724.38551228977;39335.99999999996;40104.39843402351;40406.59593404065;40983.38524922128;41316.38025429621;41419.99999999993;41437.37843932343;41491.377629335584;7137.464690148259;7547.471676982614;7653;7662.693492260303;7780.377569794403;7713.96143019287;7808.25821546955;7813.687452501893;7823.10034346049;7847.725329613465;7783.143854176036;7835.49069310493;7847.0975837778815;7853.332466740334;7891.250331218525;7822.569758663271;7830.530168189927;7832.334251588622;7865.803354916145;7875.1337352891705;7653.617319134021;7689.846203075963;7705.267999540035;7748.651310691032;7749.147593764681;37179.25641487182;37527.81236093802;37573.43639845377;37665.05837354088;37713.24573508542;3520.6303338149382;3558.9110272243142;3563.6970857477145;3576.4635304704243;3576.4635304704243;31164;31185.376292474022;31201.37597248065;31264.687353126406;31318.217044574067;4771.642126840501;4798.664093513456;4820.783064762059;4854.490278520775;4897.314375987365;187625;187988;188004.99999999863;189140;189819;46856.29715554269;47678.76160619175;47687.76156119267;47707.52292477031;47833;50158.247626285636;50218.99562008739;50320.24519632208;50332.74833625882;50345.49654503408;14947.1779052151;15436.382544698086;15485.612859678373;15487.612809679847;15508.224588770516;10601.522931468102;10758.193135514868;12352.505899763908;13329;13699.178049317074;14231.288435578179;14245.64385890361;14269.143851368952;14283.500077497238;14487;5630.268065151504;5646.096624540054;5670.943290567124;5761.222234998306;5818.679972601548;973.8001391142983;981.3572110267643;993.8211121997965;1004.8995100490039;1017.6590842067842;21931.780682193294;22068.889655551942;22109.33671989843;22416.215432459787;22641.773582264297;1054.1514081164737;1054.541274545575;1095.9726006849892;1098.8461615373853;1101.4437708956925;11767.23512971654;11769.941150294193;11823.172377933462;12071;15402.46091386796;232595;233622;234481;234621;236143;55268.44731552713;55500.72249638726;55511;55812.16281755777;55932.720336398874;1417.2276109520337;1443.5452832357773;1454.3891565542285;1456.2500312339155;1457.5554455890842;25419.983200671766;26955.86522067377;26990.460190795682;27137.86431067832;27171;36839.26321473609;37372.81313593415;37442;37465;37510.62489375071;205647;206034;207097;207162;207764;32928.506072408454;33975.830120849234;35900.82049589735;35905;35984.64015359813;41659;43063.35404968991;43224.56775432205;43372;43484;29627.40745185127;30481.695183047887;31484.212894677818;31577.684223158394;31601.8419907899;28674.713252868038;28776.85611571929;30690.386192276477;30823;31067.53398698976;35400.645993539736;35436.64563354333;35579.46630800592;35628.10929726674;35810.28379432449;30114.24714382158;31051.53422698616;31487.527687084254;31958.6804131965;32124.678753212167;23659.171928982403;23928.641070384307;24075.277741667778;24088.397790055387;24967.625485618093 10:36:09 INFO - PID 25973 | |2;jquery.html;556.8357334586296;570.5920267009087;571.9828405147847;573.1202604002855;589.6255877517776;21629.56740865182;22179.11283548656;22445.663315050268;22454.775452245474;22455.775442245573;26472.60291095635;27050.18849434515;27095.18714438565;27104.728952710466;27170.728292717067;6370.777022804203;6462.127612772286;6474.708638111273;6475.5790873593305;6509.3490650935;5987.191729116579;6298.685065746718;6557.868842623168;6569.572977756455;6573.474122070247;6479.870402591945;6482.675866206694;6516.283208847047;6518.837029074263;6520.4457621102265;6494.5453818232745;6511.34886511345;6515.315891831337;6529.053287273343;6545.901811472808;6035.849103772441;6058.636481811105;6091.51267898567;6096.96951515244;6104.938950610482;27358.5896211555;29182.41635167306;29184.854075729698;29617.851910740308;29723.70276297231;1821.6174603333316;1864.8787828791085;1865.7294692269545;1868.7383766272733;1869.2336142181775;18306;18334.449966501026;18577;19224.327148549735;19308.131134099;2373.8100951923807;2376.738558758535;2407.9759202407927;2407.987960060206;2415.2512721056355;138614;139222;140777.99999999898;141529.29235353757;141865;14038.508652197328;14629;14700.55898323052;14720.263986800617;15005.324760385809;23566.528669426516;23575.882120589285;23668.28995130149;23719.881400592887;23735.881320593286;8204.507729536246;8386.161383861687;8393.6222869971;8463.57682115904;8472.788180295542;7120.181179164359;7231.56610603355;7256.294770728875;7274.49078564506;7943;7919.2872641462545;8824.337899771652;9323.533823308808;9363.391379560308;9426.805071743009;2557.565213913639;2570.588705807062;2677.9330516737236;2692.2057992892146;2719.1162872066657;918.3571499950061;945.0927109974364;948.170350942925;948.9810203795886;963.604921981984;18976.335828245945;19125.2349906005;19893.303734369227;19978.400647980583;23505.88247058788;997.6957028106498;1004.2568499310457;1018.465305714491;1039.7608550033535;1045.5504133222635;10899.509522071527;11210.934961178675;11225.270357426742;11377.886221137682;11464.713382165346;493377;497952;501582;523832;531365;120722;126320;126958.36520817522;128134;128210;1224.2409705982348;1255.7614053329837;1286.75551645189;1293.049608537724;1295.0740220742214;19604.313849015787;20317.288894888607;20923.476913077295;21733.23933662314;21929.67105493387;57213.42786572081;58932.705336473045;59299.70350148222;59454;60137.39862601318;65140.34859651343;65407.67296163489;66079.33920660923;66316.33683663102;66852.33147668462;12700.491980320683;13298.800517992044;14531.418743250151;14938.402463901322;15344.846551534789;23644.408889777893;23715.88142059279;24193.39516512031;25505.48989020246;25538.489230215662;18803.153858076694;18911.243550258387;18959.71560426567;19030.904845475685;19512.707309390655;14843;14995.005238408328;16044.358225670843;16958.830411695726;17577.472675819747;19890.60218795645;19975.101120449905;20399.08204130788;20436.69344959797;20479.59040819205;14851.257437128317;15067.849321506645;15122.168280744665;15132.319045643193;15165.848341516443;18557.628847422708;18874.056297184812;18928.242870285587;19242.422727318204;19382.709259361403 10:36:09 INFO - PID 25973 | |3;mootools.html;1351.1150196621213;1391.471240928447;1409.9284543746755;1414.8090007848937;1424.488635513459;13209.867901320984;13571.253581053039;13674.384652690627;13745.381457834397;13950.23273719945;14274.643133921658;14464.204468754215;14533.636659083502;14555.126692398464;14566.563003109924;2619.986900065497;2680.8793604287853;2682.235562864584;2684.7852171826303;2688.8386696798157;2550.0947163756878;2577.8324408913454;2597.0780372967606;2629.7633213010827;2643.193825883105;2626.592878103897;2637.406583518712;2640.5511063119316;2643.7091919888894;2658.7607115359615;2486.465409936872;2501.012100220421;2531.1520640585427;2533.3160046787357;2552.451222987048;2536.5814640584467;2536.644869718241;2560.295918622375;2563.371973866396;2572.408346080412;13795.2412617306;13909.234992075431;13993.510227142002;14011.229382383965;14063.36714847824;7384.667689953965;7613.885791713129;7628.961855190689;7635.847283054363;7648.120466146409;4689.155951928651;4846.442659094214;4887.486813884562;4888.902221955576;4924.113659541281;1792.829681180286;1820.1991123905439;1849.8150184981528;1875.5967466994525;1888.8961107139103;21159;21181.682274765735;21266.574668506542;21436.249731259486;21437;6223.719932603044;6298.118263443122;6321.399467050623;6388.840278993062;6399.424051835357;14793.11241325524;14843.851561484247;14895.03182293169;14896;14914.627134321729;7093.1488221413765;7345.265473452612;7352.264773522605;7352.485326027127;7353.77938661841;6664.566803157876;6752.324767523209;6784.694688739019;6927.861442771217;6938.791836244921;4965.875853103629;5113.437521872591;5150.510701483353;5165.612579056586;5222.3733152022005;1395.413926151019;1455.0687559961632;1499.3028241867366;1505.8795296376484;1533.4556232537511;792.5007245435339;796.7928338631882;827.4249396669377;838.2455789789238;848.2026894719068;7081.858362832714;7128.893066604005;7463.664135113933;7635.770926872203;7709.498882572615;686.7836631461074;687.8761822871832;694.264080075122;695.7703957693949;775.8642237608396;4248.383984322318;4297.290946993773;4549.385832912514;4652.883677908012;4782.665213435096;18359.724604130948;19173.808261917202;19198.80801191998;19218.13518391676;19219.903900480687;18076.276948922157;18721;18935.242590296508;19020.809791902182;19328.903355483413;10927;11076.169287303484;11080.556777728962;11083.72290692739;11114.16643751738;7093.184283807428;7454.329110380092;7507.849843003;7572.4699271050495;7617.542947423172;15736.527904162893;16341.918290408472;16725.665486690443;16763.664726705643;17229.65540689204;16492.752608710638;17191.91404043022;17286.394976175772;17356.91321543384;17451.912740436215;11281.379524126252;11376.431178441211;11524.366159861289;11535.192536522363;11625.18623696367;12901.225926444444;13016.438027436769;13040.478380864659;13121.803172952223;13123.60629181126;10194.133498652698;10626.681199564026;10689.89310106889;10755.623553175601;10973;9607.615695372107;9768.218542516724;9810.705678829647;9845.212383009199;10034.046765557261;8227.465214761021;8294.37792165578;8305.83388332242;8340.165983401854;8362.623681934207;6258.655773932477;6379.138816259746;6503.414692677682;6588.736450541925;6627.271000190071;6180.227471566054;6326.272478664829;6536.8365790855605;6543.836404089936;6614.5039122067 10:36:09 INFO - PID 25973 | |4;prototype.html;493.01397205588825;502.46236526916204;522.0993785719634;524.8819015721466;527.6675694312585;6112.755489780415;6165.568410211287;6246.750129994801;6271.247450305964;6277.278113016999;5834.753619856354;6016.398360163981;6036.49087728068;6087.7260523276445;6109.755609775603;4896.412430508326;4930.827421040264;4933.1367010773065;4933.7533123343865;4972.676776009566;4881.633877459187;4889.926651100236;4903.387076615423;4918.827841025565;4939.60483161348;4880.463149053601;5086.465921078289;5095.872603184932;5104.157813960692;5128.5640720538795;5071.594272458195;5072.264521644378;5114.744262786846;5147.099257629937;5157.071727089123;4722.7402492862875;4782.904341913142;4794.616430685537;4806.687565308243;4821.807127714887;5986.3714309997695;6032.728527216286;6043.909341359883;6087.786927457518;6115;5803.359471440484;5940.465358117747;5958.672273024982;6017.097435384683;6018.368071352489;6412.35876412355;6486.870262594722;6492.188476440445;6518.739250429977;6523.412892839668;5199.506046925536;5215.9046600214;5239.449857764956;5253.3958594761325;5258.579313654898;6802.897956530656;6917.481188910851;6928.653567321664;6940.6529673516125;6970.686319115652;5368.838934831883;5398.946010539844;5449.536789372868;5452.59105567084;5467.781288748405;5470.857394049581;5515.4760297771645;5534.584906132056;5561.555075593943;5563.109902415675;5882.647041177543;5955.970220148872;5965.940340596539;5970.223870896755;5982.641041537435;6589.374009469093;6633.635150066696;6636;6646.501512386591;6647.235567909655;1826.2603645523584;1860.3116846766513;1871.5321169707572;1914.2821441959265;1937.86434949555;1410.168000879486;1413.1026797983354;1424.7008128293176;1426.785982102693;1432.534426311432;5719.513841323451;5754.1944127822135;5758.683272420057;5782.277215348082;5790.565707571865;6410.358964103646;6436.388543088399;6496.382843629847;6620.801375958729;6696.698648560827;5703.74333155009;5738;5739.192154471328;5788.507976821933;5821.563382746311;3496.9825150874085;3517.982410087933;3523.8590456381457;3555.0756803231347;3595.2742683511538;6506.60960342381;6546.967265163644;6549.9345006550275;6596.142501474777;6618.801435956929;6843.692033858489;6853.4174595158975;6905.551139175937;6941.826454338682;6986.755463558751;6358.33237510064;6514.088027676129;6514.1531600891585;6536.901946470807;6554.246261679968;6641.867162656817;6674.632895190811;6705.497087718538;6707.195136583641;6803.489738269551;6635.966820166062;6689.531732778659;6702.631355275506;6724.125863637696;6749.42629876466;6477.611343319416;6485.902711459426;6490.8052758417325;6497.610143391412;6504.869902602016;4981.576565991786;5032.760421612494;5046.59627229828;5055.368078990126;5056.721880296619;6793.762218322335;6798;6807.217170025312;6818.420434263143;6849.31506849331;6274.905876411766;6281.71732272058;6286.9194094892255;6349.14286571307;6444.677766111769;6310.968445157745;6318.957372033563;6351.3331100235655;6458.933141394897;6487.708053137526;6302.779402720883;6339.714712837841;6396;6416.582922110048;6423.614583125028;6463.353664633687;6480.935190648033;6523.836904077436;6527.902081468686;6559.147310849559;6299.181106456132;6303.590266632654;6304.5271604628915;6320.715567799552;6338.683065846597 10:36:09 INFO - PID 25973 | |5;yui.html;880.9955950220248;888.1429420609112;906.0169715858293;909.0727457992843;914.8033172867835;17880.37418690346;18720.531986700324;18843.52891177721;18854.151563179654;18877.15052822623;18865.434036978877;21124.683129753066;21181;21195.894020529915;21212.363629091113;1038.5222797513134;1065.8934106589318;1066.211003857148;1066.5147357952153;1067.0449947297163;967.7000129959699;1009.7071849163734;1043.3583346242083;1060.210143443132;1064.3081996702167;1099.4173088263233;1100.9559617615287;1101.130107215299;1101.867775866893;1104.7403860092872;1086.6577028236081;1087.2497976396262;1088.7931293054335;1089.0362029603778;1097.8902109788996;802.8073262417037;803.6986130201175;804.0391731880405;805.2752522729531;811.8213992921548;17550.473485795446;17968.640627187513;18014.36949706767;18038.458846234633;18566;20230.49423764403;20569.69145462819;21122.894385527972;21126.894365528075;21149.68275475869;13737.175769453865;14612.780808287884;14696.779548306784;14731.410743570244;14738.336774845158;3447.87932422364;3468.8265586720563;3487.6337984511515;3489.057954352311;3490.493878387645;114172;117467.412662937;119613.40193299064;122296.38851805773;123711.38144309311;16445.6710865782;17348.566285842702;17382.391616293622;17386.565335866704;17408.21663025167;30811;31083.844580777404;31274.68725312763;31352.529712054336;31384.686153138176;8772.517511536927;8778.692745753868;9148.771280718036;9171.220446262143;9212;4269.807858646368;4347.282698354736;4348.108637729258;4355.716878402894;4358.0412309291905;4794.760261986887;5082.110630639697;5208.088584497697;5728.885422291531;5786.826395208151;986.6941248213077;1004.161525126513;1018.2057994764095;1022.7749895023084;1023.636609003793;679.2901418018183;691.7647999680032;693.6774399904069;694.6387878303254;705.7600415858633;10555.736106597396;10679.679609611723;11501.654950351503;11534.942325288488;11867;641.0640464921174;657.8947368421126;667.4793660944471;679.8334408069956;682.952193346471;4780.402449693788;5035.892103737172;5173.81891633791;5222.190560463135;5322.654027488201;93787.53106234425;97765.51117244369;101727.49136254271;103001;103120.48439757753;84493;88610.55694721485;90513;91709;94110.52944735232;74944.62527687436;75403.62298188584;76889.61555192189;78564.6071769649;79341.60329198318;10147.949260253947;10363.481825908826;10447.94776026115;10505.26463147603;10558.683239502827;35246.823765881;36755.26489470249;37149.628503714615;37720.811395942845;37732.62267377291;47668.52331476641;48203.75898120487;48726.512734872194;63828;63830;17502;18107.909460452614;18146.274149033892;18568.535786605444;18985.335513257523;19925.10337034808;19999.600007999466;20079.799202007795;21013.684794728397;21412.892935535223;18575.721364179277;18807.435776926715;18882.433526994213;18926.242950282387;19006.809931900505;19221.32725354606;19229.903850481216;19247.422577322704;19405.2237910482;20159.596808063463;18385.356512521998;18759.624807504046;19007.33474328392;19202.61594768069;19227.80772192316;12835.679108022001;13004.154729942524;13566.118202316818;13679.863201368256;13943.930280348533;13683.521076762265;14273.14361138335;14374.425022998963;14391.064580802215;14415 10:36:09 INFO - PID 25973 | __end_tp_report 10:36:09 INFO - PID 25973 | __start_cc_report 10:36:09 INFO - PID 25973 | _x_x_mozilla_cycle_collect,363 10:36:09 INFO - PID 25973 | __end_cc_report 10:36:09 INFO - PID 25973 | __startTimestamp1501176969299__endTimestamp 10:36:09 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | ------- Summary: start ------- 10:36:09 INFO - PID 25973 | Number of tests: 6 10:36:09 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | [#0] dojo.html Cycles:165 Average:6122.74 Median:6445.10 stddev:859.17 (13.3%) stddev-sans-first:829.42 10:36:09 INFO - PID 25973 | Values: 3144.0 3160.1 3184.2 3189.8 3198.2 6082.4 6206.7 6230.0 6243.6 6258.9 6188.3 6231.1 6240.1 6243.4 6250.2 5664.1 5700.6 5713.6 5732.1 5788.9 5759.5 5775.9 5778.1 5785.4 5821.6 132.1 5631.0 5667.5 5799.7 5810.4 5239.1 5624.3 5627.7 5728.0 5735.0 5627.9 5644.9 5691.8 5710.1 5715.5 6124.8 6134.7 6152.9 6189.9 6212.4 6610.3 6613.2 6702.5 6713.3 6724.2 6609.1 6682.9 6692.8 6805.5 6806.4 6192.7 6217.5 6219.4 6220.5 6226.8 6775.2 6876.5 6886.1 6887.9 6892.5 6538.0 6560.2 6560.4 6573.4 6575.0 6595.1 6641.9 6652.3 6655.8 6734.7 6558.0 6585.7 6620.6 6691.7 6728.2 6545.2 6604.5 6645.2 6691.6 6711.1 5367.1 5384.8 5412.6 5419.1 5426.9 4637.5 4639.3 4695.8 4714.3 4738.9 5763.3 5775.2 5844.9 5852.2 5857.5 6553.1 6664.7 6687.9 6745.5 6760.6 5785.1 5847.5 5864.4 5868.5 5876.5 5918.0 5952.6 5954.3 5960.9 5965.1 6487.4 6570.5 6587.5 6589.7 6600.7 6677.2 6743.5 6757.7 6759.6 6781.5 6459.9 6499.5 6551.1 6556.3 6564.6 6442.0 6544.8 6547.0 6554.1 6662.4 6754.7 6781.1 6784.0 6786.3 6789.6 6494.1 6541.1 6544.8 6583.2 6588.1 6445.1 6462.4 6550.4 6551.4 6578.2 6380.1 6459.1 6460.0 6472.5 6478.9 6500.8 6520.1 6571.7 6585.2 6594.5 6201.3 6296.7 6334.1 6345.5 6350.9 10:36:09 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | [#1] ext.html Cycles:180 Average:37697.85 Median:19569.19 stddev:54620.61 (279.1%) stddev-sans-first:54703.37 10:36:09 INFO - PID 25973 | Values: 747.6 823.7 843.4 855.0 1163.3 30375.0 30724.4 39336.0 40104.4 40406.6 40983.4 41316.4 41420.0 41437.4 41491.4 7137.5 7547.5 7653.0 7662.7 7780.4 7714.0 7808.3 7813.7 7823.1 7847.7 7783.1 7835.5 7847.1 7853.3 7891.3 7822.6 7830.5 7832.3 7865.8 7875.1 7653.6 7689.8 7705.3 7748.7 7749.1 37179.3 37527.8 37573.4 37665.1 37713.2 3520.6 3558.9 3563.7 3576.5 3576.5 31164.0 31185.4 31201.4 31264.7 31318.2 4771.6 4798.7 4820.8 4854.5 4897.3 187625.0 187988.0 188005.0 189140.0 189819.0 46856.3 47678.8 47687.8 47707.5 47833.0 50158.2 50219.0 50320.2 50332.7 50345.5 14947.2 15436.4 15485.6 15487.6 15508.2 10601.5 10758.2 12352.5 13329.0 13699.2 14231.3 14245.6 14269.1 14283.5 14487.0 5630.3 5646.1 5670.9 5761.2 5818.7 973.8 981.4 993.8 1004.9 1017.7 21931.8 22068.9 22109.3 22416.2 22641.8 1054.2 1054.5 1096.0 1098.8 1101.4 11767.2 11769.9 11823.2 12071.0 15402.5 232595.0 233622.0 234481.0 234621.0 236143.0 55268.4 55500.7 55511.0 55812.2 55932.7 1417.2 1443.5 1454.4 1456.3 1457.6 25420.0 26955.9 26990.5 27137.9 27171.0 36839.3 37372.8 37442.0 37465.0 37510.6 205647.0 206034.0 207097.0 207162.0 207764.0 32928.5 33975.8 35900.8 35905.0 35984.6 41659.0 43063.4 43224.6 43372.0 43484.0 29627.4 30481.7 31484.2 31577.7 31601.8 28674.7 28776.9 30690.4 30823.0 31067.5 35400.6 35436.6 35579.5 35628.1 35810.3 30114.2 31051.5 31487.5 31958.7 32124.7 23659.2 23928.6 24075.3 24088.4 24967.6 10:36:09 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | [#2] jquery.html Cycles:180 Average:35673.17 Median:13054.85 stddev:85971.36 (658.5%) stddev-sans-first:86172.11 10:36:09 INFO - PID 25973 | Values: 556.8 570.6 572.0 573.1 589.6 21629.6 22179.1 22445.7 22454.8 22455.8 26472.6 27050.2 27095.2 27104.7 27170.7 6370.8 6462.1 6474.7 6475.6 6509.3 5987.2 6298.7 6557.9 6569.6 6573.5 6479.9 6482.7 6516.3 6518.8 6520.4 6494.5 6511.3 6515.3 6529.1 6545.9 6035.8 6058.6 6091.5 6097.0 6104.9 27358.6 29182.4 29184.9 29617.9 29723.7 1821.6 1864.9 1865.7 1868.7 1869.2 18306.0 18334.4 18577.0 19224.3 19308.1 2373.8 2376.7 2408.0 2408.0 2415.3 138614.0 139222.0 140778.0 141529.3 141865.0 14038.5 14629.0 14700.6 14720.3 15005.3 23566.5 23575.9 23668.3 23719.9 23735.9 8204.5 8386.2 8393.6 8463.6 8472.8 7120.2 7231.6 7256.3 7274.5 7943.0 7919.3 8824.3 9323.5 9363.4 9426.8 2557.6 2570.6 2677.9 2692.2 2719.1 918.4 945.1 948.2 949.0 963.6 18976.3 19125.2 19893.3 19978.4 23505.9 997.7 1004.3 1018.5 1039.8 1045.6 10899.5 11210.9 11225.3 11377.9 11464.7 493377.0 497952.0 501582.0 523832.0 531365.0 120722.0 126320.0 126958.4 128134.0 128210.0 1224.2 1255.8 1286.8 1293.0 1295.1 19604.3 20317.3 20923.5 21733.2 21929.7 57213.4 58932.7 59299.7 59454.0 60137.4 65140.3 65407.7 66079.3 66316.3 66852.3 12700.5 13298.8 14531.4 14938.4 15344.8 23644.4 23715.9 24193.4 25505.5 25538.5 18803.2 18911.2 18959.7 19030.9 19512.7 14843.0 14995.0 16044.4 16958.8 17577.5 19890.6 19975.1 20399.1 20436.7 20479.6 14851.3 15067.8 15122.2 15132.3 15165.8 18557.6 18874.1 18928.2 19242.4 19382.7 10:36:09 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | [#3] mootools.html Cycles:180 Average:8434.10 Median:2567.89 stddev:5779.53 (225.1%) stddev-sans-first:5771.24 10:36:09 INFO - PID 25973 | Values: 1351.1 1391.5 1409.9 1414.8 1424.5 13209.9 13571.3 13674.4 13745.4 13950.2 14274.6 14464.2 14533.6 14555.1 14566.6 2620.0 2680.9 2682.2 2684.8 2688.8 2550.1 2577.8 2597.1 2629.8 2643.2 2626.6 2637.4 2640.6 2643.7 2658.8 2486.5 2501.0 2531.2 2533.3 2552.5 2536.6 2536.6 2560.3 2563.4 2572.4 13795.2 13909.2 13993.5 14011.2 14063.4 7384.7 7613.9 7629.0 7635.8 7648.1 4689.2 4846.4 4887.5 4888.9 4924.1 1792.8 1820.2 1849.8 1875.6 1888.9 21159.0 21181.7 21266.6 21436.2 21437.0 6223.7 6298.1 6321.4 6388.8 6399.4 14793.1 14843.9 14895.0 14896.0 14914.6 7093.1 7345.3 7352.3 7352.5 7353.8 6664.6 6752.3 6784.7 6927.9 6938.8 4965.9 5113.4 5150.5 5165.6 5222.4 1395.4 1455.1 1499.3 1505.9 1533.5 792.5 796.8 827.4 838.2 848.2 7081.9 7128.9 7463.7 7635.8 7709.5 686.8 687.9 694.3 695.8 775.9 4248.4 4297.3 4549.4 4652.9 4782.7 18359.7 19173.8 19198.8 19218.1 19219.9 18076.3 18721.0 18935.2 19020.8 19328.9 10927.0 11076.2 11080.6 11083.7 11114.2 7093.2 7454.3 7507.8 7572.5 7617.5 15736.5 16341.9 16725.7 16763.7 17229.7 16492.8 17191.9 17286.4 17356.9 17451.9 11281.4 11376.4 11524.4 11535.2 11625.2 12901.2 13016.4 13040.5 13121.8 13123.6 10194.1 10626.7 10689.9 10755.6 10973.0 9607.6 9768.2 9810.7 9845.2 10034.0 8227.5 8294.4 8305.8 8340.2 8362.6 6258.7 6379.1 6503.4 6588.7 6627.3 6180.2 6326.3 6536.8 6543.8 6614.5 10:36:09 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | [#4] prototype.html Cycles:180 Average:5562.01 Median:6065.82 stddev:1501.99 (24.8%) stddev-sans-first:1457.22 10:36:09 INFO - PID 25973 | Values: 493.0 502.5 522.1 524.9 527.7 6112.8 6165.6 6246.8 6271.2 6277.3 5834.8 6016.4 6036.5 6087.7 6109.8 4896.4 4930.8 4933.1 4933.8 4972.7 4881.6 4889.9 4903.4 4918.8 4939.6 4880.5 5086.5 5095.9 5104.2 5128.6 5071.6 5072.3 5114.7 5147.1 5157.1 4722.7 4782.9 4794.6 4806.7 4821.8 5986.4 6032.7 6043.9 6087.8 6115.0 5803.4 5940.5 5958.7 6017.1 6018.4 6412.4 6486.9 6492.2 6518.7 6523.4 5199.5 5215.9 5239.4 5253.4 5258.6 6802.9 6917.5 6928.7 6940.7 6970.7 5368.8 5398.9 5449.5 5452.6 5467.8 5470.9 5515.5 5534.6 5561.6 5563.1 5882.6 5956.0 5965.9 5970.2 5982.6 6589.4 6633.6 6636.0 6646.5 6647.2 1826.3 1860.3 1871.5 1914.3 1937.9 1410.2 1413.1 1424.7 1426.8 1432.5 5719.5 5754.2 5758.7 5782.3 5790.6 6410.4 6436.4 6496.4 6620.8 6696.7 5703.7 5738.0 5739.2 5788.5 5821.6 3497.0 3518.0 3523.9 3555.1 3595.3 6506.6 6547.0 6549.9 6596.1 6618.8 6843.7 6853.4 6905.6 6941.8 6986.8 6358.3 6514.1 6514.2 6536.9 6554.2 6641.9 6674.6 6705.5 6707.2 6803.5 6636.0 6689.5 6702.6 6724.1 6749.4 6477.6 6485.9 6490.8 6497.6 6504.9 4981.6 5032.8 5046.6 5055.4 5056.7 6793.8 6798.0 6807.2 6818.4 6849.3 6274.9 6281.7 6286.9 6349.1 6444.7 6311.0 6319.0 6351.3 6458.9 6487.7 6302.8 6339.7 6396.0 6416.6 6423.6 6463.4 6480.9 6523.8 6527.9 6559.1 6299.2 6303.6 6304.5 6320.7 6338.7 10:36:09 INFO - PID 25973 | 10:36:09 INFO - PID 25973 | [#5] yui.html Cycles:180 Average:22209.85 Median:19665.16 stddev:29225.76 (148.6%) stddev-sans-first:29263.86 10:36:09 INFO - PID 25973 | Values: 881.0 888.1 906.0 909.1 914.8 17880.4 18720.5 18843.5 18854.2 18877.2 18865.4 21124.7 21181.0 21195.9 21212.4 1038.5 1065.9 1066.2 1066.5 1067.0 967.7 1009.7 1043.4 1060.2 1064.3 1099.4 1101.0 1101.1 1101.9 1104.7 1086.7 1087.2 1088.8 1089.0 1097.9 802.8 803.7 804.0 805.3 811.8 17550.5 17968.6 18014.4 18038.5 18566.0 20230.5 20569.7 21122.9 21126.9 21149.7 13737.2 14612.8 14696.8 14731.4 14738.3 3447.9 3468.8 3487.6 3489.1 3490.5 114172.0 117467.4 119613.4 122296.4 123711.4 16445.7 17348.6 17382.4 17386.6 17408.2 30811.0 31083.8 31274.7 31352.5 31384.7 8772.5 8778.7 9148.8 9171.2 9212.0 4269.8 4347.3 4348.1 4355.7 4358.0 4794.8 5082.1 5208.1 5728.9 5786.8 986.7 1004.2 1018.2 1022.8 1023.6 679.3 691.8 693.7 694.6 705.8 10555.7 10679.7 11501.7 11534.9 11867.0 641.1 657.9 667.5 679.8 683.0 4780.4 5035.9 5173.8 5222.2 5322.7 93787.5 97765.5 101727.5 103001.0 103120.5 84493.0 88610.6 90513.0 91709.0 94110.5 74944.6 75403.6 76889.6 78564.6 79341.6 10147.9 10363.5 10447.9 10505.3 10558.7 35246.8 36755.3 37149.6 37720.8 37732.6 47668.5 48203.8 48726.5 63828.0 63830.0 17502.0 18107.9 18146.3 18568.5 18985.3 19925.1 19999.6 20079.8 21013.7 21412.9 18575.7 18807.4 18882.4 18926.2 19006.8 19221.3 19229.9 19247.4 19405.2 20159.6 18385.4 18759.6 19007.3 19202.6 19227.8 12835.7 13004.2 13566.1 13679.9 13943.9 13683.5 14273.1 14374.4 14391.1 14415.0 10:36:09 INFO - PID 25973 | -------- Summary: end -------- 10:36:09 INFO - PID 25973 | 10:36:10 INFO - TEST-INFO | 25973: exit 0 10:36:10 INFO - TEST-OK | dromaeo_css | took 1113888ms 10:36:10 INFO - TEST-START | kraken 10:36:10 INFO - Initialising browser for kraken test... 10:36:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39099/getInfo.html -profile /tmp/tmpqfVQ_d/profile 10:36:10 INFO - TEST-INFO | started process 26342 (/builds/slave/test/build/application/firefox/firefox http://localhost:39099/getInfo.html) 10:36:16 INFO - TEST-INFO | 26342: exit 0 10:36:16 INFO - Browser initialized. 10:36:16 INFO - Running cycle 1/1 for kraken test... 10:36:16 INFO - TEST-INFO | started process 26568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqfVQ_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:17 INFO - PID 26568 | 10:36:17 INFO - PID 26568 | (/builds/slave/test/build/application/firefox/firefox:26622): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:36:17 INFO - PID 26568 | 10:36:28 INFO - PID 26568 | RSS: Main: 171438080 10:36:28 INFO - PID 26568 | 10:36:30 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39099/tests/kraken/driver.html?testName=audio-beat-detection) 10:36:31 INFO - PID 26568 | RSS: Main: 177766400 10:36:31 INFO - PID 26568 | 10:36:34 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39099/tests/kraken/driver.html?testName=audio-dft) 10:36:35 INFO - PID 26568 | RSS: Main: 178274304 10:36:35 INFO - PID 26568 | 10:36:38 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39099/tests/kraken/driver.html?testName=audio-fft) 10:36:38 INFO - PID 26568 | RSS: Main: 172830720 10:36:38 INFO - PID 26568 | 10:36:41 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39099/tests/kraken/driver.html?testName=audio-oscillator) 10:36:41 INFO - PID 26568 | RSS: Main: 174145536 10:36:41 INFO - PID 26568 | 10:36:44 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:36:44 INFO - PID 26568 | RSS: Main: 174161920 10:36:44 INFO - PID 26568 | 10:36:47 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39099/tests/kraken/driver.html?testName=imaging-darkroom) 10:36:48 INFO - PID 26568 | RSS: Main: 176508928 10:36:48 INFO - PID 26568 | 10:36:52 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39099/tests/kraken/driver.html?testName=imaging-desaturate) 10:36:52 INFO - PID 26568 | RSS: Main: 176066560 10:36:52 INFO - PID 26568 | 10:36:55 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39099/tests/kraken/driver.html?testName=json-parse-financial) 10:36:56 INFO - PID 26568 | RSS: Main: 177307648 10:36:56 INFO - PID 26568 | 10:36:57 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:36:58 INFO - PID 26568 | RSS: Main: 177422336 10:36:58 INFO - PID 26568 | 10:37:00 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39099/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:01 INFO - PID 26568 | RSS: Main: 174116864 10:37:01 INFO - PID 26568 | 10:37:03 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:03 INFO - PID 26568 | RSS: Main: 173748224 10:37:03 INFO - PID 26568 | 10:37:06 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:07 INFO - PID 26568 | RSS: Main: 174600192 10:37:07 INFO - PID 26568 | 10:37:10 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:37:11 INFO - PID 26568 | RSS: Main: 174534656 10:37:11 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | Cycle 1(1): loaded http://localhost:39099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39099/tests/kraken/driver.html?testName=ai-astar) 10:37:13 INFO - PID 26568 | RSS: Main: 176152576 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | __start_tp_report 10:37:13 INFO - PID 26568 | _x_x_mozilla_page_load 10:37:13 INFO - PID 26568 | _x_x_mozilla_page_load_details 10:37:13 INFO - PID 26568 | |i|pagename|runs| 10:37:13 INFO - PID 26568 | |0;ai-astar;101;116;103;109;111;112;116;100;109;109 10:37:13 INFO - PID 26568 | |1;audio-beat-detection;156;124;149;176;117;145;148;120;180;121 10:37:13 INFO - PID 26568 | |2;audio-dft;162;168;163;161;167;170;163;166;170;163 10:37:13 INFO - PID 26568 | |3;audio-fft;75;78;84;173;75;78;79;91;99;79 10:37:13 INFO - PID 26568 | |4;audio-oscillator;79;80;132;81;78;78;130;79;79;128 10:37:13 INFO - PID 26568 | |5;imaging-gaussian-blur;113;116;116;117;113;119;118;122;114;119 10:37:13 INFO - PID 26568 | |6;imaging-darkroom;149;149;163;152;151;150;150;151;150;150 10:37:13 INFO - PID 26568 | |7;imaging-desaturate;94;94;95;103;98;94;99;98;99;94 10:37:13 INFO - PID 26568 | |8;json-parse-financial;57;57;58;64;65;57;56;60;62;61 10:37:13 INFO - PID 26568 | |9;json-stringify-tinderbox;61;54;53;54;53;55;53;53;54;65 10:37:13 INFO - PID 26568 | |10;stanford-crypto-aes;83;93;86;83;90;82;100;81;82;81 10:37:13 INFO - PID 26568 | |11;stanford-crypto-ccm;128;127;138;128;139;126;130;131;130;157 10:37:13 INFO - PID 26568 | |12;stanford-crypto-pbkdf2;175;179;177;180;178;186;172;177;178;173 10:37:13 INFO - PID 26568 | |13;stanford-crypto-sha256-iterative;70;78;69;67;69;71;73;70;71;68 10:37:13 INFO - PID 26568 | __end_tp_report 10:37:13 INFO - PID 26568 | __start_cc_report 10:37:13 INFO - PID 26568 | _x_x_mozilla_cycle_collect,970 10:37:13 INFO - PID 26568 | __end_cc_report 10:37:13 INFO - PID 26568 | __startTimestamp1501177033352__endTimestamp 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | ------- Summary: start ------- 10:37:13 INFO - PID 26568 | Number of tests: 14 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:5.68 (5.2%) stddev-sans-first:5.32 10:37:13 INFO - PID 26568 | Values: 101.0 116.0 103.0 109.0 111.0 112.0 116.0 100.0 109.0 109.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:148.50 stddev:22.95 (15.5%) stddev-sans-first:23.89 10:37:13 INFO - PID 26568 | Values: 156.0 124.0 149.0 176.0 117.0 145.0 148.0 120.0 180.0 121.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.50 stddev:3.33 (2.0%) stddev-sans-first:3.32 10:37:13 INFO - PID 26568 | Values: 162.0 168.0 163.0 161.0 167.0 170.0 163.0 166.0 170.0 163.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#3] audio-fft Cycles:10 Average:91.10 Median:79.00 stddev:29.77 (37.7%) stddev-sans-first:31.00 10:37:13 INFO - PID 26568 | Values: 75.0 78.0 84.0 173.0 75.0 78.0 79.0 91.0 99.0 79.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.00 stddev:24.60 (31.1%) stddev-sans-first:25.45 10:37:13 INFO - PID 26568 | Values: 79.0 80.0 132.0 81.0 78.0 78.0 130.0 79.0 79.0 128.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.50 stddev:2.91 (2.5%) stddev-sans-first:2.76 10:37:13 INFO - PID 26568 | Values: 113.0 116.0 116.0 117.0 113.0 119.0 118.0 122.0 114.0 119.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:150.50 stddev:4.14 (2.8%) stddev-sans-first:4.29 10:37:13 INFO - PID 26568 | Values: 149.0 149.0 163.0 152.0 151.0 150.0 150.0 151.0 150.0 150.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.50 stddev:3.08 (3.2%) stddev-sans-first:3.10 10:37:13 INFO - PID 26568 | Values: 94.0 94.0 95.0 103.0 98.0 94.0 99.0 98.0 99.0 94.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.50 stddev:3.20 (5.3%) stddev-sans-first:3.24 10:37:13 INFO - PID 26568 | Values: 57.0 57.0 58.0 64.0 65.0 57.0 56.0 60.0 62.0 61.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:54.00 stddev:4.12 (7.6%) stddev-sans-first:3.86 10:37:13 INFO - PID 26568 | Values: 61.0 54.0 53.0 54.0 53.0 55.0 53.0 53.0 54.0 65.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:83.00 stddev:6.33 (7.6%) stddev-sans-first:6.62 10:37:13 INFO - PID 26568 | Values: 83.0 93.0 86.0 83.0 90.0 82.0 100.0 81.0 82.0 81.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:130.50 stddev:9.38 (7.2%) stddev-sans-first:9.75 10:37:13 INFO - PID 26568 | Values: 128.0 127.0 138.0 128.0 139.0 126.0 130.0 131.0 130.0 157.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:178.00 stddev:3.92 (2.2%) stddev-sans-first:4.06 10:37:13 INFO - PID 26568 | Values: 175.0 179.0 177.0 180.0 178.0 186.0 172.0 177.0 178.0 173.0 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:3.10 (4.4%) stddev-sans-first:3.28 10:37:13 INFO - PID 26568 | Values: 70.0 78.0 69.0 67.0 69.0 71.0 73.0 70.0 71.0 68.0 10:37:13 INFO - PID 26568 | -------- Summary: end -------- 10:37:13 INFO - PID 26568 | 10:37:13 INFO - PID 26568 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:37:14 INFO - TEST-INFO | 26568: exit 0 10:37:14 INFO - TEST-OK | kraken | took 63987ms 10:37:14 INFO - SUITE-END | took 1177s 10:37:14 INFO - Completed test suite (00:19:38) 10:37:14 INFO - javascript benchmark 10:37:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8379.77447553051, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3144.0253521408367, 3160.0993716790713, 3184.1721152500345, 3189.840507974601, 3198.200449887528, 6082.422169893853, 6206.6586337751405, 6229.968850155748, 6243.594166379182, 6258.874822503547, 6188.257409110913, 6231.096491008812, 6240.126382306481, 6243.406876346739, 6250.249970003594, 5664.1220610805185, 5700.600957932947, 5713.628614140089, 5732.0828667413225, 5788.884222315552, 5759.539236861041, 5775.855603609902, 5778.133280008012, 5785.421457854202, 5821.592488525805, 132.05536431902783, 5630.971845140789, 5667.518260947824, 5799.73901174446, 5810.418958104176, 5239.1355426354985, 5624.3250809902665, 5627.662340259598, 5727.971360143214, 5735.0, 5627.943720562783, 5644.915326270109, 5691.8292451226525, 5710.14347847822, 5715.5427565794635, 6124.785632502841, 6134.662593557353, 6152.938470615326, 6189.9381006189815, 6212.4408803207925, 6610.305917878602, 6613.2064152301555, 6702.530822842403, 6713.328667133296, 6724.226713927912, 6609.140811694497, 6682.866342673119, 6692.799216023527, 6805.455563554904, 6806.421454176401, 6192.659403732793, 6217.502599792006, 6219.40915613016, 6220.502359811204, 6226.813195604139, 6775.1531058617675, 6876.518643694893, 6886.139232595926, 6887.862242755117, 6892.517523773388, 6537.967310163419, 6560.212774467094, 6560.40956313934, 6573.375529324802, 6574.9671251644395, 6595.0766892635065, 6641.900371494431, 6652.334766523309, 6655.767048153388, 6734.6632668367365, 6557.967210163919, 6585.736570537125, 6620.569662971891, 6691.7323307068145, 6728.192616885907, 6545.247296560957, 6604.537682362285, 6645.169353830771, 6691.631960242136, 6711.094002309724, 5367.141257398797, 5384.811531596453, 5412.56699464042, 5419.051665958442, 5426.9185962210595, 4637.5130611286, 4639.280911458729, 4695.835645752382, 4714.316424118552, 4738.857834264978, 5763.308402991668, 5775.16260142277, 5844.912326315109, 5852.15143804146, 5857.47282744555, 6553.082568440422, 6664.7000884959325, 6687.899681504781, 6745.527813053137, 6760.628165450849, 5785.10330898703, 5847.532197424196, 5864.354920958691, 5868.471837534557, 5876.500497457764, 5917.970410148007, 5952.5833191676165, 5954.315253745788, 5960.880782384328, 5965.105234214816, 6487.416132548094, 6570.507211959122, 6587.50593705474, 6589.7364105435245, 6600.735970561123, 6677.165354330708, 6743.527953043338, 6757.729690812509, 6759.594424334556, 6781.525293229427, 6459.935400646122, 6499.545031847725, 6551.115599394021, 6556.311587283267, 6564.573302735307, 6441.967790161019, 6544.8363790905605, 6546.967265163644, 6554.115194448688, 6662.400383965466, 6754.662266886734, 6781.11845460087, 6784.0, 6786.253512113763, 6789.62657053847, 6494.058361537456, 6541.08424820516, 6544.8363790905605, 6583.210014798255, 6588.143541339787, 6445.097686324012, 6462.3537646235, 6550.377714117151, 6551.44312733423, 6578.177727784027, 6380.106785050004, 6459.128017717548, 6460.030995350735, 6472.514561407819, 6478.935210647834, 6500.804975850732, 6520.119783829123, 6571.704273307617, 6585.242697089896, 6594.538382313192, 6201.2868520118955, 6296.716647750954, 6334.081558174131, 6345.524085693499, 6350.936490635035], "value": 6063.031508668082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.5925620536807, 823.7487566292282, 843.3632607381426, 854.9572521373926, 1163.2729544034978, 30375.0, 30724.38551228977, 39335.99999999996, 40104.39843402351, 40406.59593404065, 40983.38524922128, 41316.38025429621, 41419.99999999993, 41437.37843932343, 41491.377629335584, 7137.464690148259, 7547.471676982614, 7653.0, 7662.693492260303, 7780.377569794403, 7713.96143019287, 7808.25821546955, 7813.687452501893, 7823.10034346049, 7847.725329613465, 7783.143854176036, 7835.49069310493, 7847.0975837778815, 7853.332466740334, 7891.250331218525, 7822.569758663271, 7830.530168189927, 7832.334251588622, 7865.803354916145, 7875.1337352891705, 7653.617319134021, 7689.846203075963, 7705.267999540035, 7748.651310691032, 7749.147593764681, 37179.25641487182, 37527.81236093802, 37573.43639845377, 37665.05837354088, 37713.24573508542, 3520.6303338149382, 3558.9110272243142, 3563.6970857477145, 3576.4635304704243, 3576.4635304704243, 31164.0, 31185.376292474022, 31201.37597248065, 31264.687353126406, 31318.217044574067, 4771.642126840501, 4798.664093513456, 4820.783064762059, 4854.490278520775, 4897.314375987365, 187625.0, 187988.0, 188004.99999999863, 189140.0, 189819.0, 46856.29715554269, 47678.76160619175, 47687.76156119267, 47707.52292477031, 47833.0, 50158.247626285636, 50218.99562008739, 50320.24519632208, 50332.74833625882, 50345.49654503408, 14947.1779052151, 15436.382544698086, 15485.612859678373, 15487.612809679847, 15508.224588770516, 10601.522931468102, 10758.193135514868, 12352.505899763908, 13329.0, 13699.178049317074, 14231.288435578179, 14245.64385890361, 14269.143851368952, 14283.500077497238, 14487.0, 5630.268065151504, 5646.096624540054, 5670.943290567124, 5761.222234998306, 5818.679972601548, 973.8001391142983, 981.3572110267643, 993.8211121997965, 1004.8995100490039, 1017.6590842067842, 21931.780682193294, 22068.889655551942, 22109.33671989843, 22416.215432459787, 22641.773582264297, 1054.1514081164737, 1054.541274545575, 1095.9726006849892, 1098.8461615373853, 1101.4437708956925, 11767.23512971654, 11769.941150294193, 11823.172377933462, 12071.0, 15402.46091386796, 232595.0, 233622.0, 234481.0, 234621.0, 236143.0, 55268.44731552713, 55500.72249638726, 55511.0, 55812.16281755777, 55932.720336398874, 1417.2276109520337, 1443.5452832357773, 1454.3891565542285, 1456.2500312339155, 1457.5554455890842, 25419.983200671766, 26955.86522067377, 26990.460190795682, 27137.86431067832, 27171.0, 36839.26321473609, 37372.81313593415, 37442.0, 37465.0, 37510.62489375071, 205647.0, 206034.0, 207097.0, 207162.0, 207764.0, 32928.506072408454, 33975.830120849234, 35900.82049589735, 35905.0, 35984.64015359813, 41659.0, 43063.35404968991, 43224.56775432205, 43372.0, 43484.0, 29627.40745185127, 30481.695183047887, 31484.212894677818, 31577.684223158394, 31601.8419907899, 28674.713252868038, 28776.85611571929, 30690.386192276477, 30823.0, 31067.53398698976, 35400.645993539736, 35436.64563354333, 35579.46630800592, 35628.10929726674, 35810.28379432449, 30114.24714382158, 31051.53422698616, 31487.527687084254, 31958.6804131965, 32124.678753212167, 23659.171928982403, 23928.641070384307, 24075.277741667778, 24088.397790055387, 24967.625485618093], "value": 17062.117605430452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8357334586296, 570.5920267009087, 571.9828405147847, 573.1202604002855, 589.6255877517776, 21629.56740865182, 22179.11283548656, 22445.663315050268, 22454.775452245474, 22455.775442245573, 26472.60291095635, 27050.18849434515, 27095.18714438565, 27104.728952710466, 27170.728292717067, 6370.777022804203, 6462.127612772286, 6474.708638111273, 6475.5790873593305, 6509.3490650935, 5987.191729116579, 6298.685065746718, 6557.868842623168, 6569.572977756455, 6573.474122070247, 6479.870402591945, 6482.675866206694, 6516.283208847047, 6518.837029074263, 6520.4457621102265, 6494.5453818232745, 6511.34886511345, 6515.315891831337, 6529.053287273343, 6545.901811472808, 6035.849103772441, 6058.636481811105, 6091.51267898567, 6096.96951515244, 6104.938950610482, 27358.5896211555, 29182.41635167306, 29184.854075729698, 29617.851910740308, 29723.70276297231, 1821.6174603333316, 1864.8787828791085, 1865.7294692269545, 1868.7383766272733, 1869.2336142181775, 18306.0, 18334.449966501026, 18577.0, 19224.327148549735, 19308.131134099, 2373.8100951923807, 2376.738558758535, 2407.9759202407927, 2407.987960060206, 2415.2512721056355, 138614.0, 139222.0, 140777.99999999898, 141529.29235353757, 141865.0, 14038.508652197328, 14629.0, 14700.55898323052, 14720.263986800617, 15005.324760385809, 23566.528669426516, 23575.882120589285, 23668.28995130149, 23719.881400592887, 23735.881320593286, 8204.507729536246, 8386.161383861687, 8393.6222869971, 8463.57682115904, 8472.788180295542, 7120.181179164359, 7231.56610603355, 7256.294770728875, 7274.49078564506, 7943.0, 7919.2872641462545, 8824.337899771652, 9323.533823308808, 9363.391379560308, 9426.805071743009, 2557.565213913639, 2570.588705807062, 2677.9330516737236, 2692.2057992892146, 2719.1162872066657, 918.3571499950061, 945.0927109974364, 948.170350942925, 948.9810203795886, 963.604921981984, 18976.335828245945, 19125.2349906005, 19893.303734369227, 19978.400647980583, 23505.88247058788, 997.6957028106498, 1004.2568499310457, 1018.465305714491, 1039.7608550033535, 1045.5504133222635, 10899.509522071527, 11210.934961178675, 11225.270357426742, 11377.886221137682, 11464.713382165346, 493377.0, 497952.0, 501582.0, 523832.0, 531365.0, 120722.0, 126320.0, 126958.36520817522, 128134.0, 128210.0, 1224.2409705982348, 1255.7614053329837, 1286.75551645189, 1293.049608537724, 1295.0740220742214, 19604.313849015787, 20317.288894888607, 20923.476913077295, 21733.23933662314, 21929.67105493387, 57213.42786572081, 58932.705336473045, 59299.70350148222, 59454.0, 60137.39862601318, 65140.34859651343, 65407.67296163489, 66079.33920660923, 66316.33683663102, 66852.33147668462, 12700.491980320683, 13298.800517992044, 14531.418743250151, 14938.402463901322, 15344.846551534789, 23644.408889777893, 23715.88142059279, 24193.39516512031, 25505.48989020246, 25538.489230215662, 18803.153858076694, 18911.243550258387, 18959.71560426567, 19030.904845475685, 19512.707309390655, 14843.0, 14995.005238408328, 16044.358225670843, 16958.830411695726, 17577.472675819747, 19890.60218795645, 19975.101120449905, 20399.08204130788, 20436.69344959797, 20479.59040819205, 14851.257437128317, 15067.849321506645, 15122.168280744665, 15132.319045643193, 15165.848341516443, 18557.628847422708, 18874.056297184812, 18928.242870285587, 19242.422727318204, 19382.709259361403], "value": 11927.386860471395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.1150196621213, 1391.471240928447, 1409.9284543746755, 1414.8090007848937, 1424.488635513459, 13209.867901320984, 13571.253581053039, 13674.384652690627, 13745.381457834397, 13950.23273719945, 14274.643133921658, 14464.204468754215, 14533.636659083502, 14555.126692398464, 14566.563003109924, 2619.986900065497, 2680.8793604287853, 2682.235562864584, 2684.7852171826303, 2688.8386696798157, 2550.0947163756878, 2577.8324408913454, 2597.0780372967606, 2629.7633213010827, 2643.193825883105, 2626.592878103897, 2637.406583518712, 2640.5511063119316, 2643.7091919888894, 2658.7607115359615, 2486.465409936872, 2501.012100220421, 2531.1520640585427, 2533.3160046787357, 2552.451222987048, 2536.5814640584467, 2536.644869718241, 2560.295918622375, 2563.371973866396, 2572.408346080412, 13795.2412617306, 13909.234992075431, 13993.510227142002, 14011.229382383965, 14063.36714847824, 7384.667689953965, 7613.885791713129, 7628.961855190689, 7635.847283054363, 7648.120466146409, 4689.155951928651, 4846.442659094214, 4887.486813884562, 4888.902221955576, 4924.113659541281, 1792.829681180286, 1820.1991123905439, 1849.8150184981528, 1875.5967466994525, 1888.8961107139103, 21159.0, 21181.682274765735, 21266.574668506542, 21436.249731259486, 21437.0, 6223.719932603044, 6298.118263443122, 6321.399467050623, 6388.840278993062, 6399.424051835357, 14793.11241325524, 14843.851561484247, 14895.03182293169, 14896.0, 14914.627134321729, 7093.1488221413765, 7345.265473452612, 7352.264773522605, 7352.485326027127, 7353.77938661841, 6664.566803157876, 6752.324767523209, 6784.694688739019, 6927.861442771217, 6938.791836244921, 4965.875853103629, 5113.437521872591, 5150.510701483353, 5165.612579056586, 5222.3733152022005, 1395.413926151019, 1455.0687559961632, 1499.3028241867366, 1505.8795296376484, 1533.4556232537511, 792.5007245435339, 796.7928338631882, 827.4249396669377, 838.2455789789238, 848.2026894719068, 7081.858362832714, 7128.893066604005, 7463.664135113933, 7635.770926872203, 7709.498882572615, 686.7836631461074, 687.8761822871832, 694.264080075122, 695.7703957693949, 775.8642237608396, 4248.383984322318, 4297.290946993773, 4549.385832912514, 4652.883677908012, 4782.665213435096, 18359.724604130948, 19173.808261917202, 19198.80801191998, 19218.13518391676, 19219.903900480687, 18076.276948922157, 18721.0, 18935.242590296508, 19020.809791902182, 19328.903355483413, 10927.0, 11076.169287303484, 11080.556777728962, 11083.72290692739, 11114.16643751738, 7093.184283807428, 7454.329110380092, 7507.849843003, 7572.4699271050495, 7617.542947423172, 15736.527904162893, 16341.918290408472, 16725.665486690443, 16763.664726705643, 17229.65540689204, 16492.752608710638, 17191.91404043022, 17286.394976175772, 17356.91321543384, 17451.912740436215, 11281.379524126252, 11376.431178441211, 11524.366159861289, 11535.192536522363, 11625.18623696367, 12901.225926444444, 13016.438027436769, 13040.478380864659, 13121.803172952223, 13123.60629181126, 10194.133498652698, 10626.681199564026, 10689.89310106889, 10755.623553175601, 10973.0, 9607.615695372107, 9768.218542516724, 9810.705678829647, 9845.212383009199, 10034.046765557261, 8227.465214761021, 8294.37792165578, 8305.83388332242, 8340.165983401854, 8362.623681934207, 6258.655773932477, 6379.138816259746, 6503.414692677682, 6588.736450541925, 6627.271000190071, 6180.227471566054, 6326.272478664829, 6536.8365790855605, 6543.836404089936, 6614.5039122067], "value": 6115.76841453979, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.01397205588825, 502.46236526916204, 522.0993785719634, 524.8819015721466, 527.6675694312585, 6112.755489780415, 6165.568410211287, 6246.750129994801, 6271.247450305964, 6277.278113016999, 5834.753619856354, 6016.398360163981, 6036.49087728068, 6087.7260523276445, 6109.755609775603, 4896.412430508326, 4930.827421040264, 4933.1367010773065, 4933.7533123343865, 4972.676776009566, 4881.633877459187, 4889.926651100236, 4903.387076615423, 4918.827841025565, 4939.60483161348, 4880.463149053601, 5086.465921078289, 5095.872603184932, 5104.157813960692, 5128.5640720538795, 5071.594272458195, 5072.264521644378, 5114.744262786846, 5147.099257629937, 5157.071727089123, 4722.7402492862875, 4782.904341913142, 4794.616430685537, 4806.687565308243, 4821.807127714887, 5986.3714309997695, 6032.728527216286, 6043.909341359883, 6087.786927457518, 6115.0, 5803.359471440484, 5940.465358117747, 5958.672273024982, 6017.097435384683, 6018.368071352489, 6412.35876412355, 6486.870262594722, 6492.188476440445, 6518.739250429977, 6523.412892839668, 5199.506046925536, 5215.9046600214, 5239.449857764956, 5253.3958594761325, 5258.579313654898, 6802.897956530656, 6917.481188910851, 6928.653567321664, 6940.6529673516125, 6970.686319115652, 5368.838934831883, 5398.946010539844, 5449.536789372868, 5452.59105567084, 5467.781288748405, 5470.857394049581, 5515.4760297771645, 5534.584906132056, 5561.555075593943, 5563.109902415675, 5882.647041177543, 5955.970220148872, 5965.940340596539, 5970.223870896755, 5982.641041537435, 6589.374009469093, 6633.635150066696, 6636.0, 6646.501512386591, 6647.235567909655, 1826.2603645523584, 1860.3116846766513, 1871.5321169707572, 1914.2821441959265, 1937.86434949555, 1410.168000879486, 1413.1026797983354, 1424.7008128293176, 1426.785982102693, 1432.534426311432, 5719.513841323451, 5754.1944127822135, 5758.683272420057, 5782.277215348082, 5790.565707571865, 6410.358964103646, 6436.388543088399, 6496.382843629847, 6620.801375958729, 6696.698648560827, 5703.74333155009, 5738.0, 5739.192154471328, 5788.507976821933, 5821.563382746311, 3496.9825150874085, 3517.982410087933, 3523.8590456381457, 3555.0756803231347, 3595.2742683511538, 6506.60960342381, 6546.967265163644, 6549.9345006550275, 6596.142501474777, 6618.801435956929, 6843.692033858489, 6853.4174595158975, 6905.551139175937, 6941.826454338682, 6986.755463558751, 6358.33237510064, 6514.088027676129, 6514.1531600891585, 6536.901946470807, 6554.246261679968, 6641.867162656817, 6674.632895190811, 6705.497087718538, 6707.195136583641, 6803.489738269551, 6635.966820166062, 6689.531732778659, 6702.631355275506, 6724.125863637696, 6749.42629876466, 6477.611343319416, 6485.902711459426, 6490.8052758417325, 6497.610143391412, 6504.869902602016, 4981.576565991786, 5032.760421612494, 5046.59627229828, 5055.368078990126, 5056.721880296619, 6793.762218322335, 6798.0, 6807.217170025312, 6818.420434263143, 6849.31506849331, 6274.905876411766, 6281.71732272058, 6286.9194094892255, 6349.14286571307, 6444.677766111769, 6310.968445157745, 6318.957372033563, 6351.3331100235655, 6458.933141394897, 6487.708053137526, 6302.779402720883, 6339.714712837841, 6396.0, 6416.582922110048, 6423.614583125028, 6463.353664633687, 6480.935190648033, 6523.836904077436, 6527.902081468686, 6559.147310849559, 6299.181106456132, 6303.590266632654, 6304.5271604628915, 6320.715567799552, 6338.683065846597], "value": 5131.0482553673055, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.9955950220248, 888.1429420609112, 906.0169715858293, 909.0727457992843, 914.8033172867835, 17880.37418690346, 18720.531986700324, 18843.52891177721, 18854.151563179654, 18877.15052822623, 18865.434036978877, 21124.683129753066, 21181.0, 21195.894020529915, 21212.363629091113, 1038.5222797513134, 1065.8934106589318, 1066.211003857148, 1066.5147357952153, 1067.0449947297163, 967.7000129959699, 1009.7071849163734, 1043.3583346242083, 1060.210143443132, 1064.3081996702167, 1099.4173088263233, 1100.9559617615287, 1101.130107215299, 1101.867775866893, 1104.7403860092872, 1086.6577028236081, 1087.2497976396262, 1088.7931293054335, 1089.0362029603778, 1097.8902109788996, 802.8073262417037, 803.6986130201175, 804.0391731880405, 805.2752522729531, 811.8213992921548, 17550.473485795446, 17968.640627187513, 18014.36949706767, 18038.458846234633, 18566.0, 20230.49423764403, 20569.69145462819, 21122.894385527972, 21126.894365528075, 21149.68275475869, 13737.175769453865, 14612.780808287884, 14696.779548306784, 14731.410743570244, 14738.336774845158, 3447.87932422364, 3468.8265586720563, 3487.6337984511515, 3489.057954352311, 3490.493878387645, 114172.0, 117467.412662937, 119613.40193299064, 122296.38851805773, 123711.38144309311, 16445.6710865782, 17348.566285842702, 17382.391616293622, 17386.565335866704, 17408.21663025167, 30811.0, 31083.844580777404, 31274.68725312763, 31352.529712054336, 31384.686153138176, 8772.517511536927, 8778.692745753868, 9148.771280718036, 9171.220446262143, 9212.0, 4269.807858646368, 4347.282698354736, 4348.108637729258, 4355.716878402894, 4358.0412309291905, 4794.760261986887, 5082.110630639697, 5208.088584497697, 5728.885422291531, 5786.826395208151, 986.6941248213077, 1004.161525126513, 1018.2057994764095, 1022.7749895023084, 1023.636609003793, 679.2901418018183, 691.7647999680032, 693.6774399904069, 694.6387878303254, 705.7600415858633, 10555.736106597396, 10679.679609611723, 11501.654950351503, 11534.942325288488, 11867.0, 641.0640464921174, 657.8947368421126, 667.4793660944471, 679.8334408069956, 682.952193346471, 4780.402449693788, 5035.892103737172, 5173.81891633791, 5222.190560463135, 5322.654027488201, 93787.53106234425, 97765.51117244369, 101727.49136254271, 103001.0, 103120.48439757753, 84493.0, 88610.55694721485, 90513.0, 91709.0, 94110.52944735232, 74944.62527687436, 75403.62298188584, 76889.61555192189, 78564.6071769649, 79341.60329198318, 10147.949260253947, 10363.481825908826, 10447.94776026115, 10505.26463147603, 10558.683239502827, 35246.823765881, 36755.26489470249, 37149.628503714615, 37720.811395942845, 37732.62267377291, 47668.52331476641, 48203.75898120487, 48726.512734872194, 63828.0, 63830.0, 17502.0, 18107.909460452614, 18146.274149033892, 18568.535786605444, 18985.335513257523, 19925.10337034808, 19999.600007999466, 20079.799202007795, 21013.684794728397, 21412.892935535223, 18575.721364179277, 18807.435776926715, 18882.433526994213, 18926.242950282387, 19006.809931900505, 19221.32725354606, 19229.903850481216, 19247.422577322704, 19405.2237910482, 20159.596808063463, 18385.356512521998, 18759.624807504046, 19007.33474328392, 19202.61594768069, 19227.80772192316, 12835.679108022001, 13004.154729942524, 13566.118202316818, 13679.863201368256, 13943.930280348533, 13683.521076762265, 14273.14361138335, 14374.425022998963, 14391.064580802215, 14415.0], "value": 8942.151872145905, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 116.0, 103.0, 109.0, 111.0, 112.0, 116.0, 100.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 149.0, 176.0, 117.0, 145.0, 148.0, 120.0, 180.0, 121.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 163.0, 161.0, 167.0, 170.0, 163.0, 166.0, 170.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 84.0, 173.0, 75.0, 78.0, 79.0, 91.0, 99.0, 79.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 132.0, 81.0, 78.0, 78.0, 130.0, 79.0, 79.0, 128.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 116.0, 117.0, 113.0, 119.0, 118.0, 122.0, 114.0, 119.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 163.0, 152.0, 151.0, 150.0, 150.0, 151.0, 150.0, 150.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 103.0, 98.0, 94.0, 99.0, 98.0, 99.0, 94.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 64.0, 65.0, 57.0, 56.0, 60.0, 62.0, 61.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 54.0, 53.0, 54.0, 53.0, 55.0, 53.0, 53.0, 54.0, 65.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 93.0, 86.0, 83.0, 90.0, 82.0, 100.0, 81.0, 82.0, 81.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 138.0, 128.0, 139.0, 126.0, 130.0, 131.0, 130.0, 157.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 177.0, 180.0, 178.0, 186.0, 172.0, 177.0, 178.0, 173.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 69.0, 67.0, 69.0, 71.0, 73.0, 70.0, 71.0, 68.0], "value": 70.6, "unit": "score"}]}]} 10:37:14 INFO - Return code: 0 10:37:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:37:14 INFO - # TBPL SUCCESS # 10:37:14 INFO - Running post-action listener: _package_coverage_data 10:37:14 INFO - Running post-action listener: _resource_record_post_action 10:37:14 INFO - [mozharness: 2017-07-27 17:37:14.641811Z] Finished run-tests step (success) 10:37:14 INFO - Running post-run listener: _resource_record_post_run 10:37:14 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 24576; Write bytes: 441286656; Read time: 872; Write time: 920464 10:37:14 INFO - TinderboxPrint: CPU usage
13.2% 10:37:14 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 872 10:37:14 INFO - TinderboxPrint: I/O write bytes / time
441,286,656 / 920,464 10:37:14 INFO - TinderboxPrint: CPU idle
8,282.7 (86.8%) 10:37:14 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 10:37:14 INFO - TinderboxPrint: Swap in / out
0 / 0 10:37:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119205888; Read time: 372; Write time: 163580 10:37:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:37:14 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 16384; Write bytes: 322080768; Read time: 492; Write time: 756884 10:37:15 INFO - Running post-run listener: _upload_blobber_files 10:37:15 INFO - Blob upload gear active. 10:37:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:37:15 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 10:37:15 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'] 10:37:15 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 10:37:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:37:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:37:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:16 INFO - (blobuploader) - INFO - Done attempting. 10:37:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:37:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:37:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:20 INFO - (blobuploader) - INFO - Done attempting. 10:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:37:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:21 INFO - (blobuploader) - INFO - Done attempting. 10:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:37:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:21 INFO - (blobuploader) - INFO - Done attempting. 10:37:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:37:21 INFO - Return code: 0 10:37:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:37:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:37:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0267800f44d435cbfb3770a4afdcb8597da3e1730337234a252c3f5cae5078a1541b33dc7efc773314f83c88cfa60d6bf2173053469dc7a2e58291cea10c6df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe44dd5fa8c5315db7269c07947acedce3629cc027a98be8cae00257192e684c6457b350f3b40d39dc90484a5de5a3eec1b1dd41b8bc263f5040c4e24bc6bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edc544a5e64f9b8b61688bf2c7426811234ede298520611b79f9b84a94b005c77f457cad9f54f3bc68c44f47f2f5cc2c5efce41f1725137a0daacb91e910d779", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea14f40cda19c152e854486d6dee6844651ba8a1a73186bab9d44df1e61060f172d706956d5b11ad630106350c4d0506312da0a47e291d01a174173a2be464bb"} 10:37:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:37:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:37:21 INFO - Contents: 10:37:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0267800f44d435cbfb3770a4afdcb8597da3e1730337234a252c3f5cae5078a1541b33dc7efc773314f83c88cfa60d6bf2173053469dc7a2e58291cea10c6df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe44dd5fa8c5315db7269c07947acedce3629cc027a98be8cae00257192e684c6457b350f3b40d39dc90484a5de5a3eec1b1dd41b8bc263f5040c4e24bc6bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edc544a5e64f9b8b61688bf2c7426811234ede298520611b79f9b84a94b005c77f457cad9f54f3bc68c44f47f2f5cc2c5efce41f1725137a0daacb91e910d779", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea14f40cda19c152e854486d6dee6844651ba8a1a73186bab9d44df1e61060f172d706956d5b11ad630106350c4d0506312da0a47e291d01a174173a2be464bb"} 10:37:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:37:21 INFO - Copying logs to upload dir... 10:37:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:37:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.590129 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-27 10:37:21.727792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 10:37:21.732136) ========= 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=8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167 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/a0267800f44d435cbfb3770a4afdcb8597da3e1730337234a252c3f5cae5078a1541b33dc7efc773314f83c88cfa60d6bf2173053469dc7a2e58291cea10c6df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe44dd5fa8c5315db7269c07947acedce3629cc027a98be8cae00257192e684c6457b350f3b40d39dc90484a5de5a3eec1b1dd41b8bc263f5040c4e24bc6bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edc544a5e64f9b8b61688bf2c7426811234ede298520611b79f9b84a94b005c77f457cad9f54f3bc68c44f47f2f5cc2c5efce41f1725137a0daacb91e910d779", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea14f40cda19c152e854486d6dee6844651ba8a1a73186bab9d44df1e61060f172d706956d5b11ad630106350c4d0506312da0a47e291d01a174173a2be464bb"} build_url:https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/HnoLxSHAT2GalrW-E1tmuA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0267800f44d435cbfb3770a4afdcb8597da3e1730337234a252c3f5cae5078a1541b33dc7efc773314f83c88cfa60d6bf2173053469dc7a2e58291cea10c6df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe44dd5fa8c5315db7269c07947acedce3629cc027a98be8cae00257192e684c6457b350f3b40d39dc90484a5de5a3eec1b1dd41b8bc263f5040c4e24bc6bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edc544a5e64f9b8b61688bf2c7426811234ede298520611b79f9b84a94b005c77f457cad9f54f3bc68c44f47f2f5cc2c5efce41f1725137a0daacb91e910d779", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea14f40cda19c152e854486d6dee6844651ba8a1a73186bab9d44df1e61060f172d706956d5b11ad630106350c4d0506312da0a47e291d01a174173a2be464bb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 10:37:21.757109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 10:37:21.757425) ========= 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=8783db0840cc980e80bb0bd400000236-1501175783.173573-1237439167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 10:37:21.839446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 10:37:21.839741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 10:37:21.843017) ========= ========= Total master_lag: 0.26 =========