builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1501497174.2 results: success (0) revision: 26516ba270816a6cc90f5c42a9b66701369a551f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:54.197439) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:54.198029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:54.198433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:54.214924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:54.215278) ========= 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=3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 03:32:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2017-07-31 03:32:54 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:54.353189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:54.353585) ========= 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=3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014188 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:54.409754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 03:32:54.410284) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 26516ba270816a6cc90f5c42a9b66701369a551f --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 26516ba270816a6cc90f5c42a9b66701369a551f --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=3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 03:32:54,474 truncating revision to first 12 chars 2017-07-31 03:32:54,474 Setting DEBUG logging. 2017-07-31 03:32:54,474 attempt 1/10 2017-07-31 03:32:54,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/26516ba27081?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 03:32:55,296 unpacking tar archive at: mozilla-central-26516ba27081/testing/mozharness/ program finished with exit code 0 elapsedTime=1.107410 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 03:32:55.538361) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:55.538776) ========= script_repo_revision: 26516ba270816a6cc90f5c42a9b66701369a551f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:55.539289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:55.539596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 03:32:55.552853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-31 03:32:55.553291) ========= /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=3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:55 INFO - MultiFileLogger online at 20170731 03:32:55 in /builds/slave/test 03:32:55 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 03:32:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:55 INFO - {'append_to_log': False, 03:32:55 INFO - 'base_work_dir': '/builds/slave/test', 03:32:55 INFO - 'blob_upload_branch': 'Firefox', 03:32:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:55 INFO - 'branch': 'Firefox', 03:32:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:55 INFO - 'code_coverage': False, 03:32:55 INFO - 'config_files': ('talos/linux_config.py',), 03:32:55 INFO - 'default_actions': ('clobber', 03:32:55 INFO - 'read-buildbot-config', 03:32:55 INFO - 'download-and-extract', 03:32:55 INFO - 'populate-webroot', 03:32:55 INFO - 'create-virtualenv', 03:32:55 INFO - 'install', 03:32:55 INFO - 'setup-mitmproxy', 03:32:55 INFO - 'run-tests'), 03:32:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:55 INFO - 'disable_ccov_upload': False, 03:32:55 INFO - 'download_minidump_stackwalk': True, 03:32:55 INFO - 'download_symbols': 'ondemand', 03:32:55 INFO - 'enable_stylo': False, 03:32:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:55 INFO - 'gecko_profile': False, 03:32:55 INFO - 'gecko_profile_interval': 0, 03:32:55 INFO - 'installer_path': 'installer.exe', 03:32:55 INFO - 'log_level': 'info', 03:32:55 INFO - 'log_name': 'talos', 03:32:55 INFO - 'log_to_console': True, 03:32:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:55 INFO - 'opt_config_files': (), 03:32:55 INFO - 'pip_index': False, 03:32:55 INFO - 'suite': 'dromaeojs-e10s', 03:32:55 INFO - 'system_bits': '32', 03:32:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:55 INFO - 'title': 'talos-linux64-ix-030', 03:32:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:55 INFO - 'use_talos_json': True, 03:32:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:55 INFO - 'work_dir': 'build'} 03:32:55 INFO - [mozharness: 2017-07-31 10:32:55.724213Z] Running clobber step. 03:32:55 INFO - Running pre-action listener: _resource_record_pre_action 03:32:55 INFO - Running main action method: clobber 03:32:55 INFO - rmtree: /builds/slave/test/build 03:32:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:57 INFO - Running post-action listener: _resource_record_post_action 03:32:57 INFO - [mozharness: 2017-07-31 10:32:57.304297Z] Finished clobber step (success) 03:32:57 INFO - [mozharness: 2017-07-31 10:32:57.304398Z] Running read-buildbot-config step. 03:32:57 INFO - Running pre-action listener: _resource_record_pre_action 03:32:57 INFO - Running main action method: read_buildbot_config 03:32:57 INFO - Using buildbot properties: 03:32:57 INFO - { 03:32:57 INFO - "project": "", 03:32:57 INFO - "product": "firefox", 03:32:57 INFO - "who": "archaeopteryx@coole-files.de", 03:32:57 INFO - "installer_path": "public/build/target.tar.bz2", 03:32:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:32:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:32:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:32:57 INFO - "stage_platform": "linux64-pgo", 03:32:57 INFO - "basedir": "/builds/slave/test", 03:32:57 INFO - "buildnumber": 101, 03:32:57 INFO - "platform": "ubuntu64_hw", 03:32:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:32:57 INFO - "slavebuilddir": "test", 03:32:57 INFO - "taskId": "ByadJ48MRn-UQLGF5uILtQ", 03:32:57 INFO - "branch": "mozilla-central", 03:32:57 INFO - "script_repo_revision": "production", 03:32:57 INFO - "revision": "26516ba270816a6cc90f5c42a9b66701369a551f", 03:32:57 INFO - "slavename": "talos-linux64-ix-030", 03:32:57 INFO - "repo_path": "mozilla-central" 03:32:57 INFO - } 03:32:57 INFO - Finding installer, test and symbols from parent task. 03:32:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ByadJ48MRn-UQLGF5uILtQ'}, attempt #1 03:32:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ByadJ48MRn-UQLGF5uILtQ'}, attempt #1 03:32:58 INFO - Task dependencies: YRC8Ej07S6aB7aYErhWsJw 03:32:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw'}, attempt #1 03:32:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.tar.bz2 03:32:58 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.test_packages.json 03:32:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.crashreporter-symbols.zip 03:32:58 INFO - Running post-action listener: _resource_record_post_action 03:32:58 INFO - [mozharness: 2017-07-31 10:32:58.674471Z] Finished read-buildbot-config step (success) 03:32:58 INFO - [mozharness: 2017-07-31 10:32:58.674693Z] Running download-and-extract step. 03:32:58 INFO - Running pre-action listener: _resource_record_pre_action 03:32:58 INFO - Running main action method: download_and_extract 03:32:58 INFO - mkdir: /builds/slave/test/build/tests 03:32:58 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')]} 03:32:58 INFO - trying https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.test_packages.json 03:32:58 INFO - Downloading https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:32:59 INFO - Downloaded 989 bytes. 03:32:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:32:59 INFO - Using the following test package requirements: 03:32:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:32:59 INFO - u'common': [u'target.common.tests.zip'], 03:32:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:32:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:32:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:32:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:32:59 INFO - u'mozbase': [u'target.common.tests.zip'], 03:32:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:32:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:32:59 INFO - u'web-platform': [u'target.common.tests.zip', 03:32:59 INFO - u'target.web-platform.tests.tar.gz'], 03:32:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:32:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:32:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.common.tests.zip 03:32:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:32:59 INFO - Fetch https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.common.tests.zip into memory 03:33:00 INFO - Content-Length response header: 73005250 03:33:00 INFO - Bytes received: 73005250 03:33:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:33:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.common.tests.zip 03:33:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:33:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.common.tests.zip into memory 03:33:13 INFO - Content-Length response header: 73005250 03:33:13 INFO - Bytes received: 73005250 03:33:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.talos.tests.zip 03:33:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:33:27 INFO - Fetch https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.talos.tests.zip into memory 03:33:27 INFO - Content-Length response header: 14496686 03:33:27 INFO - Bytes received: 14496686 03:33:28 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')]} 03:33:28 INFO - trying https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.tar.bz2 03:33:28 INFO - Downloading https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:33:29 INFO - Downloaded 63088937 bytes. 03:33:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.tar.bz2 03:33:29 INFO - mkdir: /builds/slave/test/properties 03:33:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:29 INFO - Contents: 03:33:29 INFO - build_url:https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.tar.bz2 03:33:29 INFO - Running post-action listener: _resource_record_post_action 03:33:29 INFO - Running post-action listener: set_extra_try_arguments 03:33:29 INFO - [mozharness: 2017-07-31 10:33:29.181320Z] Finished download-and-extract step (success) 03:33:29 INFO - [mozharness: 2017-07-31 10:33:29.181417Z] Running populate-webroot step. 03:33:29 INFO - Running pre-action listener: _resource_record_pre_action 03:33:29 INFO - Running main action method: populate_webroot 03:33:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:33:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:33:29 INFO - 'tests': ['damp', 'tps']}, 03:33:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:33:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:33:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:33:29 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:29 INFO - 'ts_paint', 03:33:29 INFO - 'tpaint', 03:33:29 INFO - 'sessionrestore', 03:33:29 INFO - 'sessionrestore_many_windows', 03:33:29 INFO - 'sessionrestore_no_auto_restore', 03:33:29 INFO - 'tabpaint']}, 03:33:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:33:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:33:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:29 INFO - 'talos_options': ['--mitmproxy', 03:33:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:29 INFO - '--firstNonBlankPaint'], 03:33:29 INFO - 'tests': ['quantum_pageload_google', 03:33:29 INFO - 'quantum_pageload_youtube', 03:33:29 INFO - 'quantum_pageload_amazon', 03:33:29 INFO - 'quantum_pageload_facebook']}, 03:33:29 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:29 INFO - 'talos_options': ['--stylo', 03:33:29 INFO - '--mitmproxy', 03:33:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:29 INFO - '--firstNonBlankPaint'], 03:33:29 INFO - 'tests': ['quantum_pageload_google', 03:33:29 INFO - 'quantum_pageload_youtube', 03:33:29 INFO - 'quantum_pageload_amazon', 03:33:29 INFO - 'quantum_pageload_facebook']}, 03:33:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:29 INFO - 'tsvgr_opacity', 03:33:29 INFO - 'tart', 03:33:29 INFO - 'tscrollx', 03:33:29 INFO - 'cart', 03:33:29 INFO - 'tsvg_static']}, 03:33:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:33:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:29 INFO - 'talos_options': ['--stylo', 03:33:29 INFO - '--stylo-threads=1', 03:33:29 INFO - '--mitmproxy', 03:33:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:29 INFO - '--firstNonBlankPaint'], 03:33:29 INFO - 'tests': ['tp6_google', 03:33:29 INFO - 'tp6_youtube', 03:33:29 INFO - 'tp6_amazon', 03:33:29 INFO - 'tp6_facebook']}, 03:33:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:33:29 INFO - 'talos_options': ['--xperf_path', 03:33:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:29 INFO - 'tests': ['tp5n']}}} 03:33:29 INFO - Running post-action listener: _resource_record_post_action 03:33:29 INFO - [mozharness: 2017-07-31 10:33:29.190350Z] Finished populate-webroot step (success) 03:33:29 INFO - [mozharness: 2017-07-31 10:33:29.190440Z] Running create-virtualenv step. 03:33:29 INFO - Running pre-action listener: _resource_record_pre_action 03:33:29 INFO - Running main action method: create_virtualenv 03:33:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:29 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 03:33:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:33:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:29 INFO - Using real prefix '/usr' 03:33:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:31 INFO - Installing pip.................done. 03:33:31 INFO - Return code: 0 03:33:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:31 INFO - Reading from file tmpfile_stdout 03:33:31 INFO - Output received: 03:33:31 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) 03:33:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:31 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')]} 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:31 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')]} 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:31 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:31 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 03:33:31 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 03:33:31 INFO - Using env: {'DISPLAY': ':0', 03:33:31 INFO - 'HOME': '/home/cltbld', 03:33:31 INFO - 'LANG': 'en_US.UTF-8', 03:33:31 INFO - 'LANGUAGE': 'en_US:en', 03:33:31 INFO - 'LOGNAME': 'cltbld', 03:33:31 INFO - 'MAIL': '/var/mail/cltbld', 03:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:31 INFO - 'MOZ_NO_REMOTE': '1', 03:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:31 INFO - 'NO_EM_RESTART': '1', 03:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:31 INFO - 'PWD': '/builds/slave/test', 03:33:31 INFO - 'SHELL': '/bin/bash', 03:33:31 INFO - 'SHLVL': '1', 03:33:31 INFO - 'TERM': 'linux', 03:33:31 INFO - 'TMOUT': '86400', 03:33:31 INFO - 'USER': 'cltbld', 03:33:31 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:31 INFO - '_': '/tools/buildbot/bin/python'} 03:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:32 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 03:33:32 INFO - Cleaning up... 03:33:32 INFO - Return code: 0 03:33:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:32 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')]} 03:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:32 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')]} 03:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:32 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:32 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 03:33:32 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 03:33:32 INFO - Using env: {'DISPLAY': ':0', 03:33:32 INFO - 'HOME': '/home/cltbld', 03:33:32 INFO - 'LANG': 'en_US.UTF-8', 03:33:32 INFO - 'LANGUAGE': 'en_US:en', 03:33:32 INFO - 'LOGNAME': 'cltbld', 03:33:32 INFO - 'MAIL': '/var/mail/cltbld', 03:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:32 INFO - 'MOZ_NO_REMOTE': '1', 03:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:32 INFO - 'NO_EM_RESTART': '1', 03:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:32 INFO - 'PWD': '/builds/slave/test', 03:33:32 INFO - 'SHELL': '/bin/bash', 03:33:32 INFO - 'SHLVL': '1', 03:33:32 INFO - 'TERM': 'linux', 03:33:32 INFO - 'TMOUT': '86400', 03:33:32 INFO - 'USER': 'cltbld', 03:33:32 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:32 INFO - '_': '/tools/buildbot/bin/python'} 03:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:32 INFO - Downloading/unpacking psutil>=3.1.1 03:33:32 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 03:33:32 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 03:33:32 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 03:33:32 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 03:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:33 INFO - Installing collected packages: psutil 03:33:33 INFO - Running setup.py install for psutil 03:33:33 INFO - building 'psutil._psutil_linux' extension 03:33:33 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 03:33:33 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 03:33:33 INFO - building 'psutil._psutil_posix' extension 03:33:33 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 03:33:33 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 03:33:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:34 INFO - Successfully installed psutil 03:33:34 INFO - Cleaning up... 03:33:34 INFO - Return code: 0 03:33:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:34 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')]} 03:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:34 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')]} 03:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:34 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:34 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 03:33:34 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 03:33:34 INFO - Using env: {'DISPLAY': ':0', 03:33:34 INFO - 'HOME': '/home/cltbld', 03:33:34 INFO - 'LANG': 'en_US.UTF-8', 03:33:34 INFO - 'LANGUAGE': 'en_US:en', 03:33:34 INFO - 'LOGNAME': 'cltbld', 03:33:34 INFO - 'MAIL': '/var/mail/cltbld', 03:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:34 INFO - 'MOZ_NO_REMOTE': '1', 03:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:34 INFO - 'NO_EM_RESTART': '1', 03:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:34 INFO - 'PWD': '/builds/slave/test', 03:33:34 INFO - 'SHELL': '/bin/bash', 03:33:34 INFO - 'SHLVL': '1', 03:33:34 INFO - 'TERM': 'linux', 03:33:34 INFO - 'TMOUT': '86400', 03:33:34 INFO - 'USER': 'cltbld', 03:33:34 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:34 INFO - '_': '/tools/buildbot/bin/python'} 03:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:34 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 03:33:34 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 03:33:34 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 03:33:34 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 03:33:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:35 INFO - Installing collected packages: mozsystemmonitor 03:33:35 INFO - Running setup.py install for mozsystemmonitor 03:33:35 INFO - Successfully installed mozsystemmonitor 03:33:35 INFO - Cleaning up... 03:33:35 INFO - Return code: 0 03:33:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33: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')]} 03:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:35 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:35 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 03:33:35 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 03:33:35 INFO - Using env: {'DISPLAY': ':0', 03:33:35 INFO - 'HOME': '/home/cltbld', 03:33:35 INFO - 'LANG': 'en_US.UTF-8', 03:33:35 INFO - 'LANGUAGE': 'en_US:en', 03:33:35 INFO - 'LOGNAME': 'cltbld', 03:33:35 INFO - 'MAIL': '/var/mail/cltbld', 03:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:35 INFO - 'MOZ_NO_REMOTE': '1', 03:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:35 INFO - 'NO_EM_RESTART': '1', 03:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:35 INFO - 'PWD': '/builds/slave/test', 03:33:35 INFO - 'SHELL': '/bin/bash', 03:33:35 INFO - 'SHLVL': '1', 03:33:35 INFO - 'TERM': 'linux', 03:33:35 INFO - 'TMOUT': '86400', 03:33:35 INFO - 'USER': 'cltbld', 03:33:35 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:35 INFO - '_': '/tools/buildbot/bin/python'} 03:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:35 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 03:33:35 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 03:33:35 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 03:33:35 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 03:33:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:36 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 03:33:36 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 03:33:36 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 03:33:36 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 03:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:37 INFO - warning: no files found matching '*.txt' 03:33:37 INFO - no previously-included directories found matching 'build' 03:33:37 INFO - no previously-included directories found matching 'dist' 03:33:37 INFO - no previously-included directories found matching '.git*' 03:33:37 INFO - Installing collected packages: jsonschema, functools32 03:33:37 INFO - Running setup.py install for functools32 03:33:37 INFO - warning: no files found matching '*.txt' 03:33:37 INFO - no previously-included directories found matching 'build' 03:33:37 INFO - no previously-included directories found matching 'dist' 03:33:37 INFO - no previously-included directories found matching '.git*' 03:33:37 INFO - Successfully installed jsonschema functools32 03:33:37 INFO - Cleaning up... 03:33:37 INFO - Return code: 0 03:33:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33:37 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')]} 03:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:37 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')]} 03:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:37 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:37 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 03:33:37 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 03:33:37 INFO - Using env: {'DISPLAY': ':0', 03:33:37 INFO - 'HOME': '/home/cltbld', 03:33:37 INFO - 'LANG': 'en_US.UTF-8', 03:33:37 INFO - 'LANGUAGE': 'en_US:en', 03:33:37 INFO - 'LOGNAME': 'cltbld', 03:33:37 INFO - 'MAIL': '/var/mail/cltbld', 03:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:37 INFO - 'MOZ_NO_REMOTE': '1', 03:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:37 INFO - 'NO_EM_RESTART': '1', 03:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:37 INFO - 'PWD': '/builds/slave/test', 03:33:37 INFO - 'SHELL': '/bin/bash', 03:33:37 INFO - 'SHLVL': '1', 03:33:37 INFO - 'TERM': 'linux', 03:33:37 INFO - 'TMOUT': '86400', 03:33:37 INFO - 'USER': 'cltbld', 03:33:37 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:37 INFO - '_': '/tools/buildbot/bin/python'} 03:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:37 INFO - Cleaning up... 03:33:37 INFO - Return code: 0 03:33:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:37 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')]} 03:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:37 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')]} 03:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:37 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:37 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 03:33:37 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 03:33:37 INFO - Using env: {'DISPLAY': ':0', 03:33:37 INFO - 'HOME': '/home/cltbld', 03:33:37 INFO - 'LANG': 'en_US.UTF-8', 03:33:37 INFO - 'LANGUAGE': 'en_US:en', 03:33:37 INFO - 'LOGNAME': 'cltbld', 03:33:37 INFO - 'MAIL': '/var/mail/cltbld', 03:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:37 INFO - 'MOZ_NO_REMOTE': '1', 03:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:37 INFO - 'NO_EM_RESTART': '1', 03:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:37 INFO - 'PWD': '/builds/slave/test', 03:33:37 INFO - 'SHELL': '/bin/bash', 03:33:37 INFO - 'SHLVL': '1', 03:33:37 INFO - 'TERM': 'linux', 03:33:37 INFO - 'TMOUT': '86400', 03:33:37 INFO - 'USER': 'cltbld', 03:33:37 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:37 INFO - '_': '/tools/buildbot/bin/python'} 03:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:37 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 03:33:37 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 03:33:37 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 03:33:37 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 03:33:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:38 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 03:33:38 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 03:33:38 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 03:33:38 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 03:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 INFO - Downloading docopt-0.6.1.tar.gz 03:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:39 INFO - Running setup.py install for blobuploader 03:33:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:39 INFO - Running setup.py install for requests 03:33:39 INFO - Running setup.py install for docopt 03:33:39 INFO - Successfully installed blobuploader requests docopt 03:33:39 INFO - Cleaning up... 03:33:39 INFO - Return code: 0 03:33:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:39 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')]} 03:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:39 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')]} 03:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:39 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:39 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 03:33:39 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 03:33:39 INFO - Using env: {'DISPLAY': ':0', 03:33:39 INFO - 'HOME': '/home/cltbld', 03:33:39 INFO - 'LANG': 'en_US.UTF-8', 03:33:39 INFO - 'LANGUAGE': 'en_US:en', 03:33:39 INFO - 'LOGNAME': 'cltbld', 03:33:39 INFO - 'MAIL': '/var/mail/cltbld', 03:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:39 INFO - 'MOZ_NO_REMOTE': '1', 03:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:39 INFO - 'NO_EM_RESTART': '1', 03:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:39 INFO - 'PWD': '/builds/slave/test', 03:33:39 INFO - 'SHELL': '/bin/bash', 03:33:39 INFO - 'SHLVL': '1', 03:33:39 INFO - 'TERM': 'linux', 03:33:39 INFO - 'TMOUT': '86400', 03:33:39 INFO - 'USER': 'cltbld', 03:33:39 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:39 INFO - '_': '/tools/buildbot/bin/python'} 03:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:40 INFO - Running setup.py (path:/tmp/pip-C2FZ3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:40 INFO - Running setup.py (path:/tmp/pip-OS_nVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:40 INFO - Running setup.py (path:/tmp/pip-VRLpgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:40 INFO - Running setup.py (path:/tmp/pip-t1f45D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:40 INFO - Running setup.py (path:/tmp/pip-lKlwj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:40 INFO - Running setup.py (path:/tmp/pip-vSJlah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:40 INFO - Running setup.py (path:/tmp/pip-PxLi9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:40 INFO - Running setup.py (path:/tmp/pip-kLofOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:40 INFO - Running setup.py (path:/tmp/pip-E9FG8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:40 INFO - Running setup.py (path:/tmp/pip-YCSSEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:40 INFO - Running setup.py (path:/tmp/pip-89wS6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:40 INFO - Running setup.py (path:/tmp/pip-ujSCeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:41 INFO - Running setup.py (path:/tmp/pip-d8mNa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:41 INFO - Running setup.py (path:/tmp/pip-XWO3LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:41 INFO - Running setup.py (path:/tmp/pip-hxeKKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:41 INFO - Running setup.py (path:/tmp/pip-X2Pydu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:41 INFO - Running setup.py (path:/tmp/pip-b1QQDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:41 INFO - Running setup.py install for manifestparser 03:33:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:41 INFO - Running setup.py install for mozcrash 03:33:41 INFO - Running setup.py install for mozdebug 03:33:41 INFO - Running setup.py install for mozdevice 03:33:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:41 INFO - Running setup.py install for mozfile 03:33:41 INFO - Running setup.py install for mozhttpd 03:33:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:41 INFO - Running setup.py install for mozinfo 03:33:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Running setup.py install for mozInstall 03:33:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Running setup.py install for mozleak 03:33:42 INFO - Running setup.py install for mozlog 03:33:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Running setup.py install for moznetwork 03:33:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Running setup.py install for mozprocess 03:33:42 INFO - Running setup.py install for mozprofile 03:33:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Running setup.py install for mozrunner 03:33:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:42 INFO - Running setup.py install for mozscreenshot 03:33:42 INFO - Running setup.py install for moztest 03:33:43 INFO - Running setup.py install for mozversion 03:33:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:43 INFO - Cleaning up... 03:33:43 INFO - Return code: 0 03:33:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:43 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')]} 03:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:43 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')]} 03:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:43 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:43 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 03:33:43 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 03:33:43 INFO - Using env: {'DISPLAY': ':0', 03:33:43 INFO - 'HOME': '/home/cltbld', 03:33:43 INFO - 'LANG': 'en_US.UTF-8', 03:33:43 INFO - 'LANGUAGE': 'en_US:en', 03:33:43 INFO - 'LOGNAME': 'cltbld', 03:33:43 INFO - 'MAIL': '/var/mail/cltbld', 03:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:43 INFO - 'MOZ_NO_REMOTE': '1', 03:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:43 INFO - 'NO_EM_RESTART': '1', 03:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:43 INFO - 'PWD': '/builds/slave/test', 03:33:43 INFO - 'SHELL': '/bin/bash', 03:33:43 INFO - 'SHLVL': '1', 03:33:43 INFO - 'TERM': 'linux', 03:33:43 INFO - 'TMOUT': '86400', 03:33:43 INFO - 'USER': 'cltbld', 03:33:43 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:43 INFO - '_': '/tools/buildbot/bin/python'} 03:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:43 INFO - Running setup.py (path:/tmp/pip-pSP7CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:43 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)) 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:43 INFO - Running setup.py (path:/tmp/pip-d9oGwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:43 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)) 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:43 INFO - Running setup.py (path:/tmp/pip-YYU1De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:43 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)) 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:43 INFO - Running setup.py (path:/tmp/pip-TlEAId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:43 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)) 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:43 INFO - Running setup.py (path:/tmp/pip-ffemlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:43 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)) 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:43 INFO - Running setup.py (path:/tmp/pip-OYrrDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:43 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)) 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:43 INFO - Running setup.py (path:/tmp/pip-gVsKhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:43 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)) 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:43 INFO - Running setup.py (path:/tmp/pip-w71hQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:43 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)) 03:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:43 INFO - Running setup.py (path:/tmp/pip-GiWYWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:44 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)) 03:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:44 INFO - Running setup.py (path:/tmp/pip-PHoM4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:44 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)) 03:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:44 INFO - Running setup.py (path:/tmp/pip-nT0bXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:44 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)) 03:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:44 INFO - Running setup.py (path:/tmp/pip-JS4gUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:44 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)) 03:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:44 INFO - Running setup.py (path:/tmp/pip-Qd65nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:44 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)) 03:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:44 INFO - Running setup.py (path:/tmp/pip-3sxlFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:44 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)) 03:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:44 INFO - Running setup.py (path:/tmp/pip-mRMNb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:44 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)) 03:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:44 INFO - Running setup.py (path:/tmp/pip-DJTVWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:44 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)) 03:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:44 INFO - Running setup.py (path:/tmp/pip-aAbeah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:44 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)) 03:33:44 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)) 03:33:44 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)) 03:33:44 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)) 03:33:44 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)) 03:33:44 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)) 03:33:44 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)) 03:33:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:44 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 03:33:44 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 03:33:44 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 03:33:44 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 03:33:45 INFO - Downloading blessings-1.6.tar.gz 03:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:45 INFO - Installing collected packages: blessings 03:33:45 INFO - Running setup.py install for blessings 03:33:45 INFO - Successfully installed blessings 03:33:45 INFO - Cleaning up... 03:33:45 INFO - Return code: 0 03:33:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:46 INFO - Reading from file tmpfile_stdout 03:33:46 INFO - Current package versions: 03:33:46 INFO - argparse == 1.2.1 03:33:46 INFO - blessings == 1.6 03:33:46 INFO - blobuploader == 1.2.4 03:33:46 INFO - docopt == 0.6.1 03:33:46 INFO - functools32 == 3.2.3-2 03:33:46 INFO - jsonschema == 2.5.1 03:33:46 INFO - manifestparser == 1.1 03:33:46 INFO - mozInstall == 1.13 03:33:46 INFO - mozcrash == 1.0 03:33:46 INFO - mozdebug == 0.1 03:33:46 INFO - mozdevice == 0.51 03:33:46 INFO - mozfile == 1.2 03:33:46 INFO - mozhttpd == 0.7 03:33:46 INFO - mozinfo == 0.10 03:33:46 INFO - mozleak == 0.1 03:33:46 INFO - mozlog == 3.5 03:33:46 INFO - moznetwork == 0.27 03:33:46 INFO - mozprocess == 0.25 03:33:46 INFO - mozprofile == 0.28 03:33:46 INFO - mozrunner == 6.13 03:33:46 INFO - mozscreenshot == 0.1 03:33:46 INFO - mozsystemmonitor == 0.3 03:33:46 INFO - moztest == 0.8 03:33:46 INFO - mozversion == 1.4 03:33:46 INFO - psutil == 3.1.1 03:33:46 INFO - requests == 1.2.3 03:33:46 INFO - wsgiref == 0.1.2 03:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:46 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:46 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 03:33:46 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 03:33:46 INFO - Using env: {'DISPLAY': ':0', 03:33:46 INFO - 'HOME': '/home/cltbld', 03:33:46 INFO - 'LANG': 'en_US.UTF-8', 03:33:46 INFO - 'LANGUAGE': 'en_US:en', 03:33:46 INFO - 'LOGNAME': 'cltbld', 03:33:46 INFO - 'MAIL': '/var/mail/cltbld', 03:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:46 INFO - 'MOZ_NO_REMOTE': '1', 03:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:46 INFO - 'NO_EM_RESTART': '1', 03:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:46 INFO - 'PWD': '/builds/slave/test', 03:33:46 INFO - 'SHELL': '/bin/bash', 03:33:46 INFO - 'SHLVL': '1', 03:33:46 INFO - 'TERM': 'linux', 03:33:46 INFO - 'TMOUT': '86400', 03:33:46 INFO - 'USER': 'cltbld', 03:33:46 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:46 INFO - '_': '/tools/buildbot/bin/python'} 03:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:46 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)) 03:33:46 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)) 03:33:46 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)) 03:33:46 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)) 03:33:46 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)) 03:33:46 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)) 03:33:46 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)) 03:33:46 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)) 03:33:46 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)) 03:33:46 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:47 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:33:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:33:47 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)) 03:33:47 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)) 03:33:47 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)) 03:33:47 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)) 03:33:47 INFO - Installing collected packages: marionette-driver, simplejson 03:33:47 INFO - Running setup.py install for marionette-driver 03:33:47 INFO - Running setup.py install for simplejson 03:33:47 INFO - building 'simplejson._speedups' extension 03:33:47 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 03:33:48 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 03:33:48 INFO - Successfully installed marionette-driver simplejson 03:33:48 INFO - Cleaning up... 03:33:48 INFO - Return code: 0 03:33:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', '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 03:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:33:48 INFO - Using env: {'DISPLAY': ':0', 03:33:48 INFO - 'HOME': '/home/cltbld', 03:33:48 INFO - 'LANG': 'en_US.UTF-8', 03:33:48 INFO - 'LANGUAGE': 'en_US:en', 03:33:48 INFO - 'LOGNAME': 'cltbld', 03:33:48 INFO - 'MAIL': '/var/mail/cltbld', 03:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:48 INFO - 'MOZ_NO_REMOTE': '1', 03:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:48 INFO - 'NO_EM_RESTART': '1', 03:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:48 INFO - 'PWD': '/builds/slave/test', 03:33:48 INFO - 'SHELL': '/bin/bash', 03:33:48 INFO - 'SHLVL': '1', 03:33:48 INFO - 'TERM': 'linux', 03:33:48 INFO - 'TMOUT': '86400', 03:33:48 INFO - 'USER': 'cltbld', 03:33:48 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:48 INFO - '_': '/tools/buildbot/bin/python'} 03:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:49 INFO - Cleaning up... 03:33:49 INFO - Return code: 0 03:33:49 INFO - Running post-action listener: _resource_record_post_action 03:33:49 INFO - Running post-action listener: _start_resource_monitoring 03:33:49 INFO - Starting resource monitoring. 03:33:49 INFO - [mozharness: 2017-07-31 10:33:49.174703Z] Finished create-virtualenv step (success) 03:33:49 INFO - [mozharness: 2017-07-31 10:33:49.175227Z] Running install step. 03:33:49 INFO - Running pre-action listener: _resource_record_pre_action 03:33:49 INFO - Running main action method: install 03:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:49 INFO - Reading from file tmpfile_stdout 03:33:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:49 INFO - Reading from file tmpfile_stdout 03:33:49 INFO - Output received: 03:33:49 INFO - Usage: mozinstall [options] installer 03:33:49 INFO - Options: 03:33:49 INFO - -h, --help show this help message and exit 03:33:49 INFO - -d DEST, --destination=DEST 03:33:49 INFO - Directory to install application into. [default: 03:33:49 INFO - "/builds/slave/test"] 03:33:49 INFO - --app=APP Application being installed. [default: firefox] 03:33:49 INFO - mkdir: /builds/slave/test/build/application 03:33:49 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'] 03:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:34:07 INFO - Reading from file tmpfile_stdout 03:34:07 INFO - Output received: 03:34:07 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:07 INFO - Running post-action listener: _resource_record_post_action 03:34:07 INFO - [mozharness: 2017-07-31 10:34:07.387135Z] Finished install step (success) 03:34:07 INFO - [mozharness: 2017-07-31 10:34:07.387388Z] Running setup-mitmproxy step. 03:34:07 INFO - Running pre-action listener: _resource_record_pre_action 03:34:07 INFO - Running main action method: setup_mitmproxy 03:34:07 INFO - Skipping: mitmproxy is not required 03:34:07 INFO - Running post-action listener: _resource_record_post_action 03:34:07 INFO - [mozharness: 2017-07-31 10:34:07.388522Z] Finished setup-mitmproxy step (success) 03:34:07 INFO - [mozharness: 2017-07-31 10:34:07.388744Z] Running run-tests step. 03:34:07 INFO - Running pre-action listener: _resource_record_pre_action 03:34:07 INFO - Running pre-action listener: _set_gcov_prefix 03:34:07 INFO - Running main action method: run_tests 03:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:07 INFO - Python 2.7.3 03:34:07 INFO - Return code: 0 03:34:07 INFO - grabbing minidump binary from tooltool 03:34:07 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')]} 03:34:07 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 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:07 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 03:34:07 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 03:34:07 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 03:34:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:07 INFO - Return code: 0 03:34:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:07 INFO - ENV: RUST_BACKTRACE is now 1 03:34:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:07 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/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 03:34:07 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/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 03:34:07 INFO - Using env: {'DISPLAY': ':0', 03:34:07 INFO - 'HOME': '/home/cltbld', 03:34:07 INFO - 'LANG': 'en_US.UTF-8', 03:34:07 INFO - 'LANGUAGE': 'en_US:en', 03:34:07 INFO - 'LOGNAME': 'cltbld', 03:34:07 INFO - 'MAIL': '/var/mail/cltbld', 03:34:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:07 INFO - 'MOZ_NO_REMOTE': '1', 03:34:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:07 INFO - 'NO_EM_RESTART': '1', 03:34:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:07 INFO - 'PWD': '/builds/slave/test', 03:34:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:07 INFO - 'RUST_BACKTRACE': '1', 03:34:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:34:07 INFO - 'SHELL': '/bin/bash', 03:34:07 INFO - 'SHLVL': '1', 03:34:07 INFO - 'TERM': 'linux', 03:34:07 INFO - 'TMOUT': '86400', 03:34:07 INFO - 'USER': 'cltbld', 03:34:07 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208', 03:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:07 INFO - '_': '/tools/buildbot/bin/python'} 03:34:07 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/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 03:34:07 INFO - mozversion application_buildid: 20170731091117 03:34:07 INFO - mozversion application_changeset: 26516ba270816a6cc90f5c42a9b66701369a551f 03:34:07 INFO - mozversion application_display_name: Nightly 03:34:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:07 INFO - mozversion application_name: Firefox 03:34:07 INFO - mozversion application_remotingname: firefox 03:34:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:34:07 INFO - mozversion application_vendor: Mozilla 03:34:07 INFO - mozversion application_version: 56.0a1 03:34:07 INFO - mozversion platform_buildid: 20170731091117 03:34:07 INFO - mozversion platform_changeset: 26516ba270816a6cc90f5c42a9b66701369a551f 03:34:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:34:07 INFO - mozversion platform_version: 56.0a1 03:34:07 INFO - using testdate: 1501497247 03:34:07 INFO - actual date: 1501497247 03:34:07 INFO - starting webserver on 'localhost:37390' 03:34:07 INFO - SUITE-START | Running 2 tests 03:34:07 INFO - TEST-START | dromaeo_css 03:34:07 INFO - Initialising browser for dromaeo_css test... 03:34:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37390/getInfo.html -profile /tmp/tmpSjee9y/profile 03:34:07 INFO - TEST-INFO | started process 3094 (/builds/slave/test/build/application/firefox/firefox http://localhost:37390/getInfo.html) 03:34:13 INFO - TEST-INFO | 3094: exit 0 03:34:13 INFO - Browser initialized. 03:34:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:13 INFO - TEST-INFO | started process 3301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSjee9y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:14 INFO - PID 3301 | 03:34:14 INFO - PID 3301 | (/builds/slave/test/build/application/firefox/firefox:3349): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:34:14 INFO - PID 3301 | 03:34:25 INFO - PID 3301 | RSS: Main: 163852288 03:34:25 INFO - PID 3301 | 03:37:23 INFO - PID 3301 | Cycle 1(1): loaded http://localhost:37390/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37390/tests/dromaeo/cssquery-ext.html) 03:37:24 INFO - PID 3301 | RSS: Main: 166305792 03:37:24 INFO - PID 3301 | 03:40:26 INFO - PID 3301 | Cycle 1(1): loaded http://localhost:37390/tests/dromaeo/cssquery-ext.html (next: http://localhost:37390/tests/dromaeo/cssquery-jquery.html) 03:40:26 INFO - PID 3301 | RSS: Main: 163618816 03:40:26 INFO - PID 3301 | 03:43:28 INFO - PID 3301 | Cycle 1(1): loaded http://localhost:37390/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37390/tests/dromaeo/cssquery-mootools.html) 03:43:29 INFO - PID 3301 | RSS: Main: 165920768 03:43:29 INFO - PID 3301 | 03:46:30 INFO - PID 3301 | Cycle 1(1): loaded http://localhost:37390/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37390/tests/dromaeo/cssquery-prototype.html) 03:46:31 INFO - PID 3301 | RSS: Main: 164286464 03:46:31 INFO - PID 3301 | 03:49:34 INFO - PID 3301 | Cycle 1(1): loaded http://localhost:37390/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37390/tests/dromaeo/cssquery-yui.html) 03:49:35 INFO - PID 3301 | RSS: Main: 167604224 03:49:35 INFO - PID 3301 | 03:52:36 INFO - PID 3301 | Cycle 1(1): loaded http://localhost:37390/tests/dromaeo/cssquery-yui.html (next: http://localhost:37390/tests/dromaeo/cssquery-dojo.html) 03:52:37 INFO - PID 3301 | RSS: Main: 167956480 03:52:37 INFO - PID 3301 | 03:52:37 INFO - PID 3301 | __start_tp_report 03:52:37 INFO - PID 3301 | _x_x_mozilla_page_load 03:52:37 INFO - PID 3301 | _x_x_mozilla_page_load_details 03:52:37 INFO - PID 3301 | |i|pagename|runs| 03:52:37 INFO - PID 3301 | |0;dojo.html;3398.9660103398974;3417.453207486802;3420.0936751760782;3427.7943323400614;3448.241386894884;6097.4512293893595;6103.176071230394;6138.447539721425;6146.200993870791;6160.907586386208;5997.490213331861;6083.54373421994;6084.787032453865;6087.147799308101;6097.329293777692;5333.733313334347;5339.786408543654;5345.198220266952;5355.303810504648;5382.838514844541;5401.162819762923;5416.377116631598;5441.700706461143;5452.482014208644;5456.836294911159;5253.579713622901;5387.81142660005;5402.297701298826;5416.756245968902;5445.83662490126;5264.605154613381;5271.5782737381305;5326.786928522854;5365.06111430502;5379.704116273603;5248.580113590941;5292.947070529322;5295.947040529622;5304.761285742151;5306.044911915854;5889.352171261158;5916.881662366729;5932.377100404482;5961.701914904237;6004.42957918997;6450.322716114787;6581.539292249545;6585.506087043491;6586.1438013058;6587.209534855848;6578.3092775258865;6657.733690652368;6669.699863506154;6713.597184168965;6746.785578595851;6233.407826256498;6238.594491358047;6262.624242545417;6272.749090036347;6278.843028924313;6671.299513551105;6815.079964204868;6839.487038472134;6839.965800170968;6842;6410.67946602668;6552.082708420825;6561.573497722633;6599.967000164968;6640.568363056386;6576.934230657632;6643.667816609151;6665.800025999228;6708.664566771642;6720.025596288511;6551.344865513411;6590.439812615981;6652.866942661217;6660;6668.466522678174;6591.703373348211;6596.70314835824;6656.600603963778;6669.0329902164885;6671.066050752898;4769.713817170981;4826.686265392738;4857;4916.975415122902;4918.967016926414;4247.915041699149;4292.6995110342605;4307.633851122627;4351.06452112791;4370.759608221515;6338.080978258126;6338.366163383625;6385.329540398284;6395.584287021422;6422.229332480132;6506.674666266667;6654.534182607171;6731.966340168267;6733.595984240961;6737.8652426951185;6262;6264.342244064308;6329.810105696836;6330.335314791972;6355.872882542323;5312.814051508256;5457.563394928476;5478.205660179252;5513.173024046425;5548.583856210719;6926.238113807477;7017.789466316019;7021.087258656342;7022.1924478685605;7095.964520177469;6631.701573429111;6645.169353830771;6646.0695502628705;6652.068710380454;6737.966310168418;6898.241193468614;6968.581885086911;6975.162980442379;6975.546589471668;7084.326988936043;6303.432691057827;6373.330800265905;6378.075179098912;6383.872322553616;6403.0715546246465;6499.5775274607;6504.869902601827;6505.577137486048;6517.3808488193545;6517.543771936109;6220.626762394271;6246.968765156145;6262.185915830913;6277.027060805583;6277.246730392382;6235.127082208403;6261.718222680081;6264.154339164154;6265.373462653698;6265.718042688181;5453.918191227214;6264;6317.5893566918;6381.521385896169;6455.61266324022;6362.745490180341;6456.935430645822;6484.805455836144;6511.990641450583;6576.901346479903;6302.873942521032;6307.936920630735;6355.841103972438;6385.968070159805;6390.041493775971 03:52:37 INFO - PID 3301 | |1;ext.html;890.4357483180383;910.0853642089695;930.7021753039025;944.2493217891775;963.2919803944104;43145.8427078646;43771.56228437715;43785.124297514034;43865;43872.78063609677;40429.191416171736;40536;40777.38833917486;40957.38563921536;41051;6714.328567143283;6829.248782633907;6835.487338449611;6835.521513494057;6837.076994605739;6699.564528305669;6794.932050679479;6796.898046529306;6797.354251346114;6800.353966373186;6786.762463313785;7336.559806411606;7499.51253168545;7551.886721699179;7561.886571701429;7447.404207663374;7508.39932805377;7511.549307041595;7515.1357593876855;7527.172011078777;7314.122305323342;7380.852382952311;7450.0687414073245;7453.6273186341;7456.664450099758;41429.1714165715;41746.791266043474;41782.79108604437;41803.790981045204;41862.372064418756;3524.947125793115;3578.284343131384;3583.552055993001;3585.6772890439725;3587.031501494582;31652.841735791404;31683.20791980196;31700.524492132638;31880.681193188237;31953.52069718956;5030.195168772979;5051.4695956924725;5061.089003979282;5073.746312684351;5079.923801142986;229267;248465;250118;251587;255277;53752.46247537475;54213.45786542084;54319.72840135774;54378.184327235125;54460.45539544633;56461.71769141128;56506.7174664124;56600;56712.43287567154;56805.431945680015;15691.686166276839;15804.762928556082;15832.208389580475;15834.366625335088;15835.366585336687;12645.178063426032;12647.620571382873;12657.746845063048;12663.49346026167;12667.239965602093;15237.238138093051;15268.16025118607;15363.692726145639;15367;15464.690706186038;5922.7927022554;5969.462748352669;6017.669028203491;6042.093685947055;6126.417990290915;1073.581303291717;1084.1922767538235;1101.4712937789907;1105.5412004018403;1106.5463160104318;24510.87744561266;24723.381915452257;24967;25000.4999900001;25075.749242507707;1191.737817680109;1212.7938250497436;1216.1486959128645;1228.6744012836605;1229.244014930829;13198.14212076212;13211.40548675312;13433.26117063571;13436.932815336057;13454.46182152703;273982;277560;277656;278179;278572;63058.684706576176;63085;63105.053424198675;63483.36516634867;63661.68169159124;1533.8619524242872;1537.4695729973364;1550.4263422533734;1562.5312406278072;1572.0960447742593;29851;30146.397072058873;30156.547651784804;30438.543421848248;30891.536626950165;54820.17769733378;55752.16371754508;55782;55891.72054139703;56065;235465;236272;236712;236783;237528;34816.825915871275;35614.465783013795;36855.44716829196;37230;37521.06197345088;48891.75554122207;50195.498045019085;50661.49338506715;50929.49070509396;51302.230466542285;33518.49722254119;34765.30469390649;35497;35760.821195893855;36295.54817807258;34111.317773644885;34784.30431391409;34887.825560872036;35143.297134057684;35635;41824;42201.36697949595;42266.1546769069;42468.36297455479;42481.57518424776;34659.30681386308;34797;35146;35278.11804704903;35396.541562190985;25462.618060729474;26354.736452635996;26383.076592319943;26889.462210756068;26897 03:52:37 INFO - PID 3301 | |2;jquery.html;559.1640497456303;559.9888002239956;568.093890245059;568.8435680187949;585.5842351930129;22981.655275170844;23242.65136022961;24022;24174.274771756853;24192.395190120256;26784.866075669644;26904.730952690516;26937.595936060974;26947.461050778973;26967.730322696818;6096.969515152429;6242.219722534684;6266.905996410034;6268.310485846553;6268.686565671721;5971.581989260753;6242.937570624281;6245.375462453741;6261.624302541862;6265.843353916143;6219.440250377465;6220.875582488347;6223.377662233763;6224.066390041485;6242.781502647408;6191.938080619204;6200.751969921198;6217.409346112112;6224.6887655617265;6230.87538249237;5744.741486633112;5777.19119323295;5786.450287222707;5794.884102317972;5795.391483894173;28036.299092522648;30601.234969125726;31142.065738027897;31144;31315.843420782978;2155.7628660847295;2184.6722991551237;2199.604071267171;2201.3836125884777;2201.460642142685;19691.310804121786;20011.699824502644;20065.799342006685;20112.195512179496;20113.793172409703;2343.871087090209;2344.4724936889234;2421.067888862783;2429.3683642252963;2459.86470744109;150139;152885.23557382255;152979;153064.234678827;154065.99999999886;14730.317420644838;15070.321835517429;15143.318550665246;15328.386864525517;15749.212539372986;23162.3051308461;23188.536229275658;23255.651165232535;23271.06915723386;24057.639135412985;10195.7451063724;10254.333468324536;10307.74230644225;10319.587216511405;10381.740456488647;9314.301427392973;9403.341766076446;9415.62337506492;9447.291453141042;9550.331476796557;9407.78916954515;9464.574094165779;9669.419834809934;9854.802903941882;9979.151772099307;2641.141628970592;2717.293503689055;2724.850133242691;2791.1207969489546;2934.3544420227518;1030.845373194027;1038.2109596706557;1042.5204405973186;1057.9100776434088;1070.9089727373105;20918.47703807417;21181.470463238544;21841.453963650718;22227.222047228268;26249.868750656125;1076.8169411200115;1091.5415525479318;1097.7639807441278;1110.2394859521253;1116.6370929447962;11297.604583839526;12030.27818330903;12160.027197824153;12172.81740773889;12228.388580570936;580616;607792;608031;610545;614575;130244;133034;136074.31962840122;136962;138605;1281.9743605127844;1290.1291628150962;1319.6700824793802;1320.735852829438;1322.2793577500286;19077.71383429222;20252.79747202568;21597.676034859804;23554.528909422057;23702.762972370747;64758.676206618664;65335.67332163309;65411.34588654053;66965.3303466959;67369.3263067363;79322.6033869827;79418.2058179434;79430;79988;80127.59936200282;14891;15090.622734431727;15416.152111633968;15438.073715577102;15619.297131628877;24400;24465.87767061153;24725.258242252043;24948.750512494644;24952.875235623706;19594.510137246114;19816;19933.700994485385;20195.899020504803;20199.8990005049;17180;17499.56251093733;17630.82369176343;17675.29298828084;18108.637827243117;20083.19667213295;20147.899260503604;20309.390718278475;20316.79683203149;20399.59200816005;15191.77212341838;15237.3905043797;15333.619974202375;15337.6165595861;15376.846231537542;19365.225390984204;19448;19469;19486.8051319485;19984.300549480697 03:52:37 INFO - PID 3301 | |3;mootools.html;1413.2582789388584;1443.9927800360997;1452.9854701452982;1464.7070585882825;1487.390170030288;14818.333175007123;15498.845011549894;15538.145402002885;15629.218539073057;15636;15935.920320398382;16175.35298588055;16180.595485112877;16189.595260118473;16194.433194838153;2661.4943160799435;2714.538528450168;2729.727027297264;2734.808563400563;2745;2675;2786.080593404182;2788.679301880279;2788.776897848177;2791.3579876628387;2750.724927507253;2761.3648860761937;2768.4463107378506;2770.044334704524;2781.4993301205773;2637.5384307746067;2648.3776312566533;2662.8402295862115;2669.412729199573;2678.2367025397766;2584.5606246938064;2595.2473782603024;2610.151700697281;2627.54018046841;2632.565626671597;15184.46854360092;15509.457168999144;15515.612109697235;15543.14512701801;15574.065556066558;7807;8114.148014458456;8134.918650813475;8138.104808471064;8140.552269625168;5022.4726403727445;5100.770465329069;5162.380514338303;5184.351956005499;5270.578353731692;1774.946751597454;1777.5378401615544;1783.8929664220188;1814.5463634091477;1821.6447792680433;27166.5925011125;27250.31874203141;27497;27501.862490687618;27501.862490687618;6638.402543770987;6682.799516014527;6870.519063665495;6893.586384816927;6943.652817359213;18193.63612727738;18330;18342.724859127124;18345.816541834676;18366.449006529827;7897.407694422941;8178.918210817935;8185.754427367188;8186.222308880647;8189.79525511867;7431.591262480507;7445.143808461988;7546.320831125225;7583.544987300779;7584;5251.947480525222;5450.427705090988;5476;5513.117901135879;5520.779168833282;1580.4310448238625;1581.549258461333;1582.8021497312836;1587.952361429159;1616.2080580515462;861.1560670542904;871.8387098386819;882.8787439951354;902.6840605787921;911.2709832134266;7767.18444563324;8986.370954033155;9052.81894362109;9201;9236.5843537041;971.455984648599;972.2562239886493;1015.3958394755109;1026.9948650256702;1032.256775121911;4660.953390466119;4999.325091112726;4999.450060493343;5197.870053248699;5279.234510995884;20731.27440539604;21310.467238319165;21893.67159492609;21945.451363716034;22131.446713832283;21670;21686.566268674538;21688.24091156802;21802.454938626663;21841.344759657237;11089.445527723581;11893.226940248856;12026.879731202751;12090.69773255658;12105.09211809118;7657.119431265476;7981.161977992228;8094.797630059295;8148.470349427268;8176.182381761776;18373.17320720544;18477.53806154857;18873.150708218436;19553.315633952745;19601.70597441011;18878.905605471886;19140.8085919139;19197.520061998002;19823.30618428348;19950.90024549868;11566.65300041;11593;11672;11718.121140914294;11852.585159519376;14364.784528231876;14367.425302988182;14485.565433037025;14511.1293322401;14515.274236288355;10701.51843167075;11201.43992800373;11215.19594135733;11478.770424591628;11619.6514104577;10836.837447438136;10917;10933.56265749361;11315.773684526428;11392.715182120513;8733.694320698745;8863.02506724247;8865.290776737975;8866.157715017063;8874.245689116238;6846.418054465426;7014.508984371045;7103.82240443993;7121.501494895308;7140.892886606809;6954.269801670752;7293.307135822089;7342.118945726547;7410.481266311306;7484.438667100098 03:52:37 INFO - PID 3301 | |4;prototype.html;499.6602310428908;502.314340924638;530.2788208037066;533.9012282727696;534.3881255961923;5906.497947674442;6019.555306726387;6080.2399700037495;6094.634321940675;6105.816825495237;5858.88282234355;5871.882562348761;5938.554608404365;5943.3462319144855;5979.730912108955;4670.112678591074;4680.227762419206;4684.929726054112;4739.668223224376;4744.952550474485;4572.222722137245;4690.458703678718;4691.671582989192;4694.225452800284;4739.0995710815005;4655.837045703401;4661.86014419568;4668.159731248374;4685.320628508881;4699.130660827758;4653.418322709661;4669.603083737852;4673.1121086993535;4694.812207511695;4700.858974230744;4217;4221.831126754926;4247.469066366704;4278.4865816102265;4314.6840213734795;5837.357890632027;5909.143174239711;5933.792317268918;5934.258217722785;5941.553898738721;5577.8047768328315;5582.162675598693;5586.994341018615;5631.155326700987;5653.180288858133;6353.777617783356;6360.268569114564;6387.169667943138;6394.328595497499;6417.7753778617525;4802.783874725646;4819.783109760034;4820;4862.902741945177;4886.14492463821;6710.765123220664;6711.154432531044;6716.227633822075;6741.426978706816;6755.459563234929;4960.801567937242;4965.3048573199785;4969.378827646544;4972.801087956514;4974.27872958419;5061.493850614983;5064.7214403207445;5076.543111120017;5077.289179514871;5086.669366491166;5568.860778480489;5586.664800111925;5613.073842815889;5649.745761440745;5652;6206.534509911684;6421.903671444932;6442.291347951722;6449.32282110381;6478.643674597943;1679.2863033210836;1686.3844696685621;1710.9306683322923;1711.512219017599;1727.1709579401956;1200.37580458163;1218.8781121887919;1222.10175520992;1230.5077968812548;1236.6537369536363;6132.386761323832;6140.907886381708;6164.969175154096;6166.876662466726;6174.684493315007;6483.740650373932;6514.478841692653;6588.287045368239;6598.802035938929;6627.668616569153;6082.847928801727;6149.3235744068115;6161.44546990773;6176.969115154396;6192.256929168529;3418.1454636340914;3419.9487007694906;3454.7408944329277;3473.322702073122;3499.702525285379;6878.283078184189;6936.861262774716;6981.860362792716;7015.473839462061;7064.611446370396;6632.668366581652;6662.300458451889;6759.560628559227;6774.543473153197;6849;6950.992106144581;6973.546719463218;6976.686049127801;6989.580625162506;6995.545289556163;6506.681592387821;6521.934780652323;6593.967030164818;6620.271770105381;6642.767503137367;6433.517486188648;6531.477481801539;6550.83622909412;6568.638724870178;6573.474122070318;6840.384365407137;6844.760433384808;6849.1438570178725;6870.45036397097;6921.89617155733;4921.188003979303;4929.802807887788;4937.086638971802;4943.824717124454;4958.355413796184;6414.61512309263;6541.509386796104;6549.770758023446;6586.868262634816;6660.234073081658;6215.285242197205;6268.404501572343;6268.623882567061;6335.144755458138;6358.936410635834;6237.625742455467;6253.437190652863;6317.778877739257;6345.206849143857;6372.936270637234;6252.531060170596;6269.185005949197;6335.968320158369;6351.841203969753;6357.650329231937;6207.720652570735;6278.434940855345;6305.873882522232;6338.890694128601;6420.1974753155855;6136.4658835291175;6186.350433204449;6188.690565471798;6249.562530622813;6253.562250642593 03:52:37 INFO - PID 3301 | |5;yui.html;943.9811203775929;949.5726922884703;962.0523784072687;965.9471176417703;979.0796651147921;18699.43901682948;19586.804131958677;19608.019599020063;19648.21407143714;20785;19729.506762330948;19760;19900.60198796023;19917.502062448446;19975.200991960304;1042.0569384706835;1043.2801367056707;1046.3198920701566;1053.073295499959;1053.4469403563114;1002.4185972136144;1064.0211005874614;1064.9946750266238;1065.5897479470382;1068.4230515521608;978.2076518020391;1092.0335503079752;1097.286763603656;1100.8403781451684;1101.8843021482749;1019.94390308533;1094.179365475893;1095.9232853700244;1096.6326280695976;1098.1818545183849;804.1476035402492;805.4844899264475;808.9352851771844;813.3777660090036;813.6826637611337;19186;19793.604127917504;19935.90032049845;19991.80008199914;20286.69569956452;20830;21070;21296;21424.678629820566;21683.34949951504;14941.701165976729;15212.011219270711;15250.466233681767;15330.770038449433;15374.538763837103;3555.484454754046;3618.0412190769202;3625.728070394731;3626.2203626220225;3630.764000339996;132070.7404632118;134249.3287533566;137631.31184344113;139441;139494.30252848772;13357.599272021855;13918.860811391958;14113.717725645429;14218.146911185362;14406.783898241534;29544.704552954194;29562.704372956425;29828.701712983027;29883;30356.026858254143;7982.521048737094;8216;8272.83454330922;8569.314454843598;8663.393562450694;4404.383386325917;4512.481064677539;4512.887177820581;4529.184746745617;4540.137373898949;5230.137027390514;5337.626366154332;5368.651037682538;5569.805056823073;5831.825045248649;1195.1992165249303;1202.2786328203008;1219.1587804414926;1220.7863623865787;1222.896053835434;705.7177129148279;705.8870580707062;712.9144502659714;732.4945787406672;741.1587847792687;12599;13871.861281387259;14438.566842994727;14448.277586120652;14499.92750036243;711.6512908674815;727.1782885339533;746.268656716421;746.302207436049;763.2863272839912;5687.43125687428;5749.453801888814;5760.164776107441;5786.94213057864;5890.204822348928;127518.36240818737;129100;129490;130391.34804326107;132771;113776;116462.41768791272;117416;118813.40593296978;123153.38423307826;95856.52071739596;99337.50331248298;99378.50310748545;100631;100854.49572752089;12738.554150604685;13399.397027133997;13640.522581709989;13736.725265494833;13792;42327.788361057996;44329.33505997477;45099;45309.320360195285;46234;76093.23906761083;76546.23453765392;79362.20637793548;82197.58901205455;83476;18863.43409697711;19040.1431935566;19253.22987080501;19478.805211948267;19556.80443195607;18821.153048112596;19266.807331927062;19279;21666.566668666223;22345.329640110824;18077.81922180814;18268.634627307645;18310;18348.082595869888;18529.166187521325;20493.38519844407;20686.896565517076;20724.896375518027;20727.378178654664;20962.790372096082;18052;18071.638567228845;18306.26774929041;18323.725144123116;18557.072146392897;13412.93293533526;13501.257430841399;13815.585532434043;13908;14194.858051419767;15017.549473515812;15125;15326.157061361286;15542.378304867678;15547.533573992798 03:52:37 INFO - PID 3301 | __end_tp_report 03:52:37 INFO - PID 3301 | __start_cc_report 03:52:37 INFO - PID 3301 | _x_x_mozilla_cycle_collect,331 03:52:37 INFO - PID 3301 | __end_cc_report 03:52:37 INFO - PID 3301 | __startTimestamp1501498357246__endTimestamp 03:52:37 INFO - PID 3301 | 03:52:37 INFO - PID 3301 | ------- Summary: start ------- 03:52:37 INFO - PID 3301 | Number of tests: 6 03:52:37 INFO - PID 3301 | 03:52:37 INFO - PID 3301 | [#0] dojo.html Cycles:165 Average:6065.25 Median:6317.59 stddev:786.83 (12.5%) stddev-sans-first:760.93 03:52:37 INFO - PID 3301 | Values: 3399.0 3417.5 3420.1 3427.8 3448.2 6097.5 6103.2 6138.4 6146.2 6160.9 5997.5 6083.5 6084.8 6087.1 6097.3 5333.7 5339.8 5345.2 5355.3 5382.8 5401.2 5416.4 5441.7 5452.5 5456.8 5253.6 5387.8 5402.3 5416.8 5445.8 5264.6 5271.6 5326.8 5365.1 5379.7 5248.6 5292.9 5295.9 5304.8 5306.0 5889.4 5916.9 5932.4 5961.7 6004.4 6450.3 6581.5 6585.5 6586.1 6587.2 6578.3 6657.7 6669.7 6713.6 6746.8 6233.4 6238.6 6262.6 6272.7 6278.8 6671.3 6815.1 6839.5 6840.0 6842.0 6410.7 6552.1 6561.6 6600.0 6640.6 6576.9 6643.7 6665.8 6708.7 6720.0 6551.3 6590.4 6652.9 6660.0 6668.5 6591.7 6596.7 6656.6 6669.0 6671.1 4769.7 4826.7 4857.0 4917.0 4919.0 4247.9 4292.7 4307.6 4351.1 4370.8 6338.1 6338.4 6385.3 6395.6 6422.2 6506.7 6654.5 6732.0 6733.6 6737.9 6262.0 6264.3 6329.8 6330.3 6355.9 5312.8 5457.6 5478.2 5513.2 5548.6 6926.2 7017.8 7021.1 7022.2 7096.0 6631.7 6645.2 6646.1 6652.1 6738.0 6898.2 6968.6 6975.2 6975.5 7084.3 6303.4 6373.3 6378.1 6383.9 6403.1 6499.6 6504.9 6505.6 6517.4 6517.5 6220.6 6247.0 6262.2 6277.0 6277.2 6235.1 6261.7 6264.2 6265.4 6265.7 5453.9 6264.0 6317.6 6381.5 6455.6 6362.7 6456.9 6484.8 6512.0 6576.9 6302.9 6307.9 6355.8 6386.0 6390.0 03:52:37 INFO - PID 3301 | 03:52:37 INFO - PID 3301 | [#1] ext.html Cycles:180 Average:43793.59 Median:19941.29 stddev:66247.21 (332.2%) stddev-sans-first:66354.73 03:52:37 INFO - PID 3301 | Values: 890.4 910.1 930.7 944.2 963.3 43145.8 43771.6 43785.1 43865.0 43872.8 40429.2 40536.0 40777.4 40957.4 41051.0 6714.3 6829.2 6835.5 6835.5 6837.1 6699.6 6794.9 6796.9 6797.4 6800.4 6786.8 7336.6 7499.5 7551.9 7561.9 7447.4 7508.4 7511.5 7515.1 7527.2 7314.1 7380.9 7450.1 7453.6 7456.7 41429.2 41746.8 41782.8 41803.8 41862.4 3524.9 3578.3 3583.6 3585.7 3587.0 31652.8 31683.2 31700.5 31880.7 31953.5 5030.2 5051.5 5061.1 5073.7 5079.9 229267.0 248465.0 250118.0 251587.0 255277.0 53752.5 54213.5 54319.7 54378.2 54460.5 56461.7 56506.7 56600.0 56712.4 56805.4 15691.7 15804.8 15832.2 15834.4 15835.4 12645.2 12647.6 12657.7 12663.5 12667.2 15237.2 15268.2 15363.7 15367.0 15464.7 5922.8 5969.5 6017.7 6042.1 6126.4 1073.6 1084.2 1101.5 1105.5 1106.5 24510.9 24723.4 24967.0 25000.5 25075.7 1191.7 1212.8 1216.1 1228.7 1229.2 13198.1 13211.4 13433.3 13436.9 13454.5 273982.0 277560.0 277656.0 278179.0 278572.0 63058.7 63085.0 63105.1 63483.4 63661.7 1533.9 1537.5 1550.4 1562.5 1572.1 29851.0 30146.4 30156.5 30438.5 30891.5 54820.2 55752.2 55782.0 55891.7 56065.0 235465.0 236272.0 236712.0 236783.0 237528.0 34816.8 35614.5 36855.4 37230.0 37521.1 48891.8 50195.5 50661.5 50929.5 51302.2 33518.5 34765.3 35497.0 35760.8 36295.5 34111.3 34784.3 34887.8 35143.3 35635.0 41824.0 42201.4 42266.2 42468.4 42481.6 34659.3 34797.0 35146.0 35278.1 35396.5 25462.6 26354.7 26383.1 26889.5 26897.0 03:52:37 INFO - PID 3301 | 03:52:37 INFO - PID 3301 | [#2] jquery.html Cycles:180 Average:39927.22 Median:23249.15 stddev:101355.20 (436.0%) stddev-sans-first:101596.43 03:52:37 INFO - PID 3301 | Values: 559.2 560.0 568.1 568.8 585.6 22981.7 23242.7 24022.0 24174.3 24192.4 26784.9 26904.7 26937.6 26947.5 26967.7 6097.0 6242.2 6266.9 6268.3 6268.7 5971.6 6242.9 6245.4 6261.6 6265.8 6219.4 6220.9 6223.4 6224.1 6242.8 6191.9 6200.8 6217.4 6224.7 6230.9 5744.7 5777.2 5786.5 5794.9 5795.4 28036.3 30601.2 31142.1 31144.0 31315.8 2155.8 2184.7 2199.6 2201.4 2201.5 19691.3 20011.7 20065.8 20112.2 20113.8 2343.9 2344.5 2421.1 2429.4 2459.9 150139.0 152885.2 152979.0 153064.2 154066.0 14730.3 15070.3 15143.3 15328.4 15749.2 23162.3 23188.5 23255.7 23271.1 24057.6 10195.7 10254.3 10307.7 10319.6 10381.7 9314.3 9403.3 9415.6 9447.3 9550.3 9407.8 9464.6 9669.4 9854.8 9979.2 2641.1 2717.3 2724.9 2791.1 2934.4 1030.8 1038.2 1042.5 1057.9 1070.9 20918.5 21181.5 21841.5 22227.2 26249.9 1076.8 1091.5 1097.8 1110.2 1116.6 11297.6 12030.3 12160.0 12172.8 12228.4 580616.0 607792.0 608031.0 610545.0 614575.0 130244.0 133034.0 136074.3 136962.0 138605.0 1282.0 1290.1 1319.7 1320.7 1322.3 19077.7 20252.8 21597.7 23554.5 23702.8 64758.7 65335.7 65411.3 66965.3 67369.3 79322.6 79418.2 79430.0 79988.0 80127.6 14891.0 15090.6 15416.2 15438.1 15619.3 24400.0 24465.9 24725.3 24948.8 24952.9 19594.5 19816.0 19933.7 20195.9 20199.9 17180.0 17499.6 17630.8 17675.3 18108.6 20083.2 20147.9 20309.4 20316.8 20399.6 15191.8 15237.4 15333.6 15337.6 15376.8 19365.2 19448.0 19469.0 19486.8 19984.3 03:52:37 INFO - PID 3301 | 03:52:37 INFO - PID 3301 | [#3] mootools.html Cycles:180 Average:9476.55 Median:2662.17 stddev:6864.01 (257.8%) stddev-sans-first:6856.53 03:52:37 INFO - PID 3301 | Values: 1413.3 1444.0 1453.0 1464.7 1487.4 14818.3 15498.8 15538.1 15629.2 15636.0 15935.9 16175.4 16180.6 16189.6 16194.4 2661.5 2714.5 2729.7 2734.8 2745.0 2675.0 2786.1 2788.7 2788.8 2791.4 2750.7 2761.4 2768.4 2770.0 2781.5 2637.5 2648.4 2662.8 2669.4 2678.2 2584.6 2595.2 2610.2 2627.5 2632.6 15184.5 15509.5 15515.6 15543.1 15574.1 7807.0 8114.1 8134.9 8138.1 8140.6 5022.5 5100.8 5162.4 5184.4 5270.6 1774.9 1777.5 1783.9 1814.5 1821.6 27166.6 27250.3 27497.0 27501.9 27501.9 6638.4 6682.8 6870.5 6893.6 6943.7 18193.6 18330.0 18342.7 18345.8 18366.4 7897.4 8178.9 8185.8 8186.2 8189.8 7431.6 7445.1 7546.3 7583.5 7584.0 5251.9 5450.4 5476.0 5513.1 5520.8 1580.4 1581.5 1582.8 1588.0 1616.2 861.2 871.8 882.9 902.7 911.3 7767.2 8986.4 9052.8 9201.0 9236.6 971.5 972.3 1015.4 1027.0 1032.3 4661.0 4999.3 4999.5 5197.9 5279.2 20731.3 21310.5 21893.7 21945.5 22131.4 21670.0 21686.6 21688.2 21802.5 21841.3 11089.4 11893.2 12026.9 12090.7 12105.1 7657.1 7981.2 8094.8 8148.5 8176.2 18373.2 18477.5 18873.2 19553.3 19601.7 18878.9 19140.8 19197.5 19823.3 19950.9 11566.7 11593.0 11672.0 11718.1 11852.6 14364.8 14367.4 14485.6 14511.1 14515.3 10701.5 11201.4 11215.2 11478.8 11619.7 10836.8 10917.0 10933.6 11315.8 11392.7 8733.7 8863.0 8865.3 8866.2 8874.2 6846.4 7014.5 7103.8 7121.5 7140.9 6954.3 7293.3 7342.1 7410.5 7484.4 03:52:37 INFO - PID 3301 | 03:52:37 INFO - PID 3301 | [#4] prototype.html Cycles:180 Average:5439.23 Median:6119.10 stddev:1558.77 (25.5%) stddev-sans-first:1518.41 03:52:37 INFO - PID 3301 | Values: 499.7 502.3 530.3 533.9 534.4 5906.5 6019.6 6080.2 6094.6 6105.8 5858.9 5871.9 5938.6 5943.3 5979.7 4670.1 4680.2 4684.9 4739.7 4745.0 4572.2 4690.5 4691.7 4694.2 4739.1 4655.8 4661.9 4668.2 4685.3 4699.1 4653.4 4669.6 4673.1 4694.8 4700.9 4217.0 4221.8 4247.5 4278.5 4314.7 5837.4 5909.1 5933.8 5934.3 5941.6 5577.8 5582.2 5587.0 5631.2 5653.2 6353.8 6360.3 6387.2 6394.3 6417.8 4802.8 4819.8 4820.0 4862.9 4886.1 6710.8 6711.2 6716.2 6741.4 6755.5 4960.8 4965.3 4969.4 4972.8 4974.3 5061.5 5064.7 5076.5 5077.3 5086.7 5568.9 5586.7 5613.1 5649.7 5652.0 6206.5 6421.9 6442.3 6449.3 6478.6 1679.3 1686.4 1710.9 1711.5 1727.2 1200.4 1218.9 1222.1 1230.5 1236.7 6132.4 6140.9 6165.0 6166.9 6174.7 6483.7 6514.5 6588.3 6598.8 6627.7 6082.8 6149.3 6161.4 6177.0 6192.3 3418.1 3419.9 3454.7 3473.3 3499.7 6878.3 6936.9 6981.9 7015.5 7064.6 6632.7 6662.3 6759.6 6774.5 6849.0 6951.0 6973.5 6976.7 6989.6 6995.5 6506.7 6521.9 6594.0 6620.3 6642.8 6433.5 6531.5 6550.8 6568.6 6573.5 6840.4 6844.8 6849.1 6870.5 6921.9 4921.2 4929.8 4937.1 4943.8 4958.4 6414.6 6541.5 6549.8 6586.9 6660.2 6215.3 6268.4 6268.6 6335.1 6358.9 6237.6 6253.4 6317.8 6345.2 6372.9 6252.5 6269.2 6336.0 6351.8 6357.7 6207.7 6278.4 6305.9 6338.9 6420.2 6136.5 6186.4 6188.7 6249.6 6253.6 03:52:37 INFO - PID 3301 | 03:52:37 INFO - PID 3301 | [#5] yui.html Cycles:180 Average:26031.87 Median:19571.80 stddev:37006.29 (189.1%) stddev-sans-first:37062.16 03:52:37 INFO - PID 3301 | Values: 944.0 949.6 962.1 965.9 979.1 18699.4 19586.8 19608.0 19648.2 20785.0 19729.5 19760.0 19900.6 19917.5 19975.2 1042.1 1043.3 1046.3 1053.1 1053.4 1002.4 1064.0 1065.0 1065.6 1068.4 978.2 1092.0 1097.3 1100.8 1101.9 1019.9 1094.2 1095.9 1096.6 1098.2 804.1 805.5 808.9 813.4 813.7 19186.0 19793.6 19935.9 19991.8 20286.7 20830.0 21070.0 21296.0 21424.7 21683.3 14941.7 15212.0 15250.5 15330.8 15374.5 3555.5 3618.0 3625.7 3626.2 3630.8 132070.7 134249.3 137631.3 139441.0 139494.3 13357.6 13918.9 14113.7 14218.1 14406.8 29544.7 29562.7 29828.7 29883.0 30356.0 7982.5 8216.0 8272.8 8569.3 8663.4 4404.4 4512.5 4512.9 4529.2 4540.1 5230.1 5337.6 5368.7 5569.8 5831.8 1195.2 1202.3 1219.2 1220.8 1222.9 705.7 705.9 712.9 732.5 741.2 12599.0 13871.9 14438.6 14448.3 14499.9 711.7 727.2 746.3 746.3 763.3 5687.4 5749.5 5760.2 5786.9 5890.2 127518.4 129100.0 129490.0 130391.3 132771.0 113776.0 116462.4 117416.0 118813.4 123153.4 95856.5 99337.5 99378.5 100631.0 100854.5 12738.6 13399.4 13640.5 13736.7 13792.0 42327.8 44329.3 45099.0 45309.3 46234.0 76093.2 76546.2 79362.2 82197.6 83476.0 18863.4 19040.1 19253.2 19478.8 19556.8 18821.2 19266.8 19279.0 21666.6 22345.3 18077.8 18268.6 18310.0 18348.1 18529.2 20493.4 20686.9 20724.9 20727.4 20962.8 18052.0 18071.6 18306.3 18323.7 18557.1 13412.9 13501.3 13815.6 13908.0 14194.9 15017.5 15125.0 15326.2 15542.4 15547.5 03:52:37 INFO - PID 3301 | -------- Summary: end -------- 03:52:37 INFO - PID 3301 | 03:52:38 INFO - TEST-INFO | 3301: exit 0 03:52:38 INFO - TEST-OK | dromaeo_css | took 1110249ms 03:52:38 INFO - TEST-START | kraken 03:52:38 INFO - Initialising browser for kraken test... 03:52:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37390/getInfo.html -profile /tmp/tmpArFrUM/profile 03:52:38 INFO - TEST-INFO | started process 3663 (/builds/slave/test/build/application/firefox/firefox http://localhost:37390/getInfo.html) 03:52:43 INFO - TEST-INFO | 3663: exit 0 03:52:43 INFO - Browser initialized. 03:52:43 INFO - Running cycle 1/1 for kraken test... 03:52:43 INFO - TEST-INFO | started process 3873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpArFrUM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:44 INFO - PID 3873 | 03:52:44 INFO - PID 3873 | (/builds/slave/test/build/application/firefox/firefox:3922): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:52:44 INFO - PID 3873 | 03:52:55 INFO - PID 3873 | RSS: Main: 164532224 03:52:55 INFO - PID 3873 | 03:52:57 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37390/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:58 INFO - PID 3873 | RSS: Main: 169381888 03:52:58 INFO - PID 3873 | 03:53:01 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37390/tests/kraken/driver.html?testName=audio-dft) 03:53:01 INFO - PID 3873 | RSS: Main: 169570304 03:53:01 INFO - PID 3873 | 03:53:04 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37390/tests/kraken/driver.html?testName=audio-fft) 03:53:05 INFO - PID 3873 | RSS: Main: 164093952 03:53:05 INFO - PID 3873 | 03:53:07 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37390/tests/kraken/driver.html?testName=audio-oscillator) 03:53:07 INFO - PID 3873 | RSS: Main: 165482496 03:53:07 INFO - PID 3873 | 03:53:10 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37390/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:10 INFO - PID 3873 | RSS: Main: 164909056 03:53:10 INFO - PID 3873 | 03:53:13 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37390/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:14 INFO - PID 3873 | RSS: Main: 167776256 03:53:14 INFO - PID 3873 | 03:53:17 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37390/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:18 INFO - PID 3873 | RSS: Main: 170127360 03:53:18 INFO - PID 3873 | 03:53:21 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37390/tests/kraken/driver.html?testName=json-parse-financial) 03:53:21 INFO - PID 3873 | RSS: Main: 169340928 03:53:21 INFO - PID 3873 | 03:53:23 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37390/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:24 INFO - PID 3873 | RSS: Main: 168939520 03:53:24 INFO - PID 3873 | 03:53:25 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37390/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:26 INFO - PID 3873 | RSS: Main: 168689664 03:53:26 INFO - PID 3873 | 03:53:28 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37390/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:29 INFO - PID 3873 | RSS: Main: 165658624 03:53:29 INFO - PID 3873 | 03:53:31 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:32 INFO - PID 3873 | RSS: Main: 165998592 03:53:32 INFO - PID 3873 | 03:53:35 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:35 INFO - PID 3873 | RSS: Main: 166252544 03:53:35 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | Cycle 1(1): loaded http://localhost:37390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37390/tests/kraken/driver.html?testName=ai-astar) 03:53:37 INFO - PID 3873 | RSS: Main: 167931904 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | __start_tp_report 03:53:37 INFO - PID 3873 | _x_x_mozilla_page_load 03:53:37 INFO - PID 3873 | _x_x_mozilla_page_load_details 03:53:37 INFO - PID 3873 | |i|pagename|runs| 03:53:37 INFO - PID 3873 | |0;ai-astar;96;107;100;105;104;106;108;99;106;107 03:53:37 INFO - PID 3873 | |1;audio-beat-detection;140;111;155;179;115;139;143;114;163;121 03:53:37 INFO - PID 3873 | |2;audio-dft;164;163;164;161;165;163;163;165;168;169 03:53:37 INFO - PID 3873 | |3;audio-fft;74;74;74;165;75;76;74;87;107;76 03:53:37 INFO - PID 3873 | |4;audio-oscillator;78;78;140;79;78;78;135;78;77;132 03:53:37 INFO - PID 3873 | |5;imaging-gaussian-blur;114;113;114;114;113;114;115;114;114;113 03:53:37 INFO - PID 3873 | |6;imaging-darkroom;149;149;149;148;148;149;148;148;148;148 03:53:37 INFO - PID 3873 | |7;imaging-desaturate;94;94;94;94;94;94;95;94;94;94 03:53:37 INFO - PID 3873 | |8;json-parse-financial;52;52;56;50;49;49;51;48;50;51 03:53:37 INFO - PID 3873 | |9;json-stringify-tinderbox;53;52;53;53;54;53;53;53;52;52 03:53:37 INFO - PID 3873 | |10;stanford-crypto-aes;82;78;82;76;75;77;77;79;78;78 03:53:37 INFO - PID 3873 | |11;stanford-crypto-ccm;122;121;121;131;126;117;116;121;135;160 03:53:37 INFO - PID 3873 | |12;stanford-crypto-pbkdf2;167;171;183;163;168;174;168;165;168;174 03:53:37 INFO - PID 3873 | |13;stanford-crypto-sha256-iterative;63;62;62;63;59;64;61;60;60;60 03:53:37 INFO - PID 3873 | __end_tp_report 03:53:37 INFO - PID 3873 | __start_cc_report 03:53:37 INFO - PID 3873 | _x_x_mozilla_cycle_collect,864 03:53:37 INFO - PID 3873 | __end_cc_report 03:53:37 INFO - PID 3873 | __startTimestamp1501498417791__endTimestamp 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | ------- Summary: start ------- 03:53:37 INFO - PID 3873 | Number of tests: 14 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#0] ai-astar Cycles:10 Average:103.80 Median:107.00 stddev:4.05 (3.8%) stddev-sans-first:3.16 03:53:37 INFO - PID 3873 | Values: 96.0 107.0 100.0 105.0 104.0 106.0 108.0 99.0 106.0 107.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:141.50 stddev:22.97 (16.2%) stddev-sans-first:24.35 03:53:37 INFO - PID 3873 | Values: 140.0 111.0 155.0 179.0 115.0 139.0 143.0 114.0 163.0 121.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.42 (1.5%) stddev-sans-first:2.55 03:53:37 INFO - PID 3873 | Values: 164.0 163.0 164.0 161.0 165.0 163.0 163.0 165.0 168.0 169.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#3] audio-fft Cycles:10 Average:88.20 Median:74.50 stddev:28.93 (38.8%) stddev-sans-first:30.22 03:53:37 INFO - PID 3873 | Values: 74.0 74.0 74.0 165.0 75.0 76.0 74.0 87.0 107.0 76.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:78.00 stddev:27.92 (35.8%) stddev-sans-first:28.91 03:53:37 INFO - PID 3873 | Values: 78.0 78.0 140.0 79.0 78.0 78.0 135.0 78.0 77.0 132.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 03:53:37 INFO - PID 3873 | Values: 114.0 113.0 114.0 114.0 113.0 114.0 115.0 114.0 114.0 113.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 03:53:37 INFO - PID 3873 | Values: 149.0 149.0 149.0 148.0 148.0 149.0 148.0 148.0 148.0 148.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:53:37 INFO - PID 3873 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:2.25 (4.4%) stddev-sans-first:2.35 03:53:37 INFO - PID 3873 | Values: 52.0 52.0 56.0 50.0 49.0 49.0 51.0 48.0 50.0 51.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#9] json-stringify-tinderbox Cycles:10 Average:52.80 Median:53.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 03:53:37 INFO - PID 3873 | Values: 53.0 52.0 53.0 53.0 54.0 53.0 53.0 53.0 52.0 52.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:2.30 (2.9%) stddev-sans-first:1.99 03:53:37 INFO - PID 3873 | Values: 82.0 78.0 82.0 76.0 75.0 77.0 77.0 79.0 78.0 78.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:124.00 stddev:13.01 (10.5%) stddev-sans-first:13.68 03:53:37 INFO - PID 3873 | Values: 122.0 121.0 121.0 131.0 126.0 117.0 116.0 121.0 135.0 160.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:169.50 stddev:5.74 (3.4%) stddev-sans-first:5.98 03:53:37 INFO - PID 3873 | Values: 167.0 171.0 183.0 163.0 168.0 174.0 168.0 165.0 168.0 174.0 03:53:37 INFO - PID 3873 | 03:53:37 INFO - PID 3873 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:1.65 (2.7%) stddev-sans-first:1.64 03:53:37 INFO - PID 3873 | Values: 63.0 62.0 62.0 63.0 59.0 64.0 61.0 60.0 60.0 60.0 03:53:37 INFO - PID 3873 | -------- Summary: end -------- 03:53:37 INFO - PID 3873 | 03:53:38 INFO - PID 3873 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:53:38 INFO - TEST-INFO | 3873: exit 0 03:53:38 INFO - TEST-OK | kraken | took 60461ms 03:53:38 INFO - SUITE-END | took 1170s 03:53:38 INFO - Completed test suite (00:19:31) 03:53:38 INFO - javascript benchmark 03:53:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8762.584076257905, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3398.9660103398974, 3417.453207486802, 3420.0936751760782, 3427.7943323400614, 3448.241386894884, 6097.4512293893595, 6103.176071230394, 6138.447539721425, 6146.200993870791, 6160.907586386208, 5997.490213331861, 6083.54373421994, 6084.787032453865, 6087.147799308101, 6097.329293777692, 5333.733313334347, 5339.786408543654, 5345.198220266952, 5355.303810504648, 5382.838514844541, 5401.162819762923, 5416.377116631598, 5441.700706461143, 5452.482014208644, 5456.836294911159, 5253.579713622901, 5387.81142660005, 5402.297701298826, 5416.756245968902, 5445.83662490126, 5264.605154613381, 5271.5782737381305, 5326.786928522854, 5365.06111430502, 5379.704116273603, 5248.580113590941, 5292.947070529322, 5295.947040529622, 5304.761285742151, 5306.044911915854, 5889.352171261158, 5916.881662366729, 5932.377100404482, 5961.701914904237, 6004.42957918997, 6450.322716114787, 6581.539292249545, 6585.506087043491, 6586.1438013058, 6587.209534855848, 6578.3092775258865, 6657.733690652368, 6669.699863506154, 6713.597184168965, 6746.785578595851, 6233.407826256498, 6238.594491358047, 6262.624242545417, 6272.749090036347, 6278.843028924313, 6671.299513551105, 6815.079964204868, 6839.487038472134, 6839.965800170968, 6842.0, 6410.67946602668, 6552.082708420825, 6561.573497722633, 6599.967000164968, 6640.568363056386, 6576.934230657632, 6643.667816609151, 6665.800025999228, 6708.664566771642, 6720.025596288511, 6551.344865513411, 6590.439812615981, 6652.866942661217, 6660.0, 6668.466522678174, 6591.703373348211, 6596.70314835824, 6656.600603963778, 6669.0329902164885, 6671.066050752898, 4769.713817170981, 4826.686265392738, 4857.0, 4916.975415122902, 4918.967016926414, 4247.915041699149, 4292.6995110342605, 4307.633851122627, 4351.06452112791, 4370.759608221515, 6338.080978258126, 6338.366163383625, 6385.329540398284, 6395.584287021422, 6422.229332480132, 6506.674666266667, 6654.534182607171, 6731.966340168267, 6733.595984240961, 6737.8652426951185, 6262.0, 6264.342244064308, 6329.810105696836, 6330.335314791972, 6355.872882542323, 5312.814051508256, 5457.563394928476, 5478.205660179252, 5513.173024046425, 5548.583856210719, 6926.238113807477, 7017.789466316019, 7021.087258656342, 7022.1924478685605, 7095.964520177469, 6631.701573429111, 6645.169353830771, 6646.0695502628705, 6652.068710380454, 6737.966310168418, 6898.241193468614, 6968.581885086911, 6975.162980442379, 6975.546589471668, 7084.326988936043, 6303.432691057827, 6373.330800265905, 6378.075179098912, 6383.872322553616, 6403.0715546246465, 6499.5775274607, 6504.869902601827, 6505.577137486048, 6517.3808488193545, 6517.543771936109, 6220.626762394271, 6246.968765156145, 6262.185915830913, 6277.027060805583, 6277.246730392382, 6235.127082208403, 6261.718222680081, 6264.154339164154, 6265.373462653698, 6265.718042688181, 5453.918191227214, 6264.0, 6317.5893566918, 6381.521385896169, 6455.61266324022, 6362.745490180341, 6456.935430645822, 6484.805455836144, 6511.990641450583, 6576.901346479903, 6302.873942521032, 6307.936920630735, 6355.841103972438, 6385.968070159805, 6390.041493775971], "value": 6005.588540995647, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.4357483180383, 910.0853642089695, 930.7021753039025, 944.2493217891775, 963.2919803944104, 43145.8427078646, 43771.56228437715, 43785.124297514034, 43865.0, 43872.78063609677, 40429.191416171736, 40536.0, 40777.38833917486, 40957.38563921536, 41051.0, 6714.328567143283, 6829.248782633907, 6835.487338449611, 6835.521513494057, 6837.076994605739, 6699.564528305669, 6794.932050679479, 6796.898046529306, 6797.354251346114, 6800.353966373186, 6786.762463313785, 7336.559806411606, 7499.51253168545, 7551.886721699179, 7561.886571701429, 7447.404207663374, 7508.39932805377, 7511.549307041595, 7515.1357593876855, 7527.172011078777, 7314.122305323342, 7380.852382952311, 7450.0687414073245, 7453.6273186341, 7456.664450099758, 41429.1714165715, 41746.791266043474, 41782.79108604437, 41803.790981045204, 41862.372064418756, 3524.947125793115, 3578.284343131384, 3583.552055993001, 3585.6772890439725, 3587.031501494582, 31652.841735791404, 31683.20791980196, 31700.524492132638, 31880.681193188237, 31953.52069718956, 5030.195168772979, 5051.4695956924725, 5061.089003979282, 5073.746312684351, 5079.923801142986, 229267.0, 248465.0, 250118.0, 251587.0, 255277.0, 53752.46247537475, 54213.45786542084, 54319.72840135774, 54378.184327235125, 54460.45539544633, 56461.71769141128, 56506.7174664124, 56600.0, 56712.43287567154, 56805.431945680015, 15691.686166276839, 15804.762928556082, 15832.208389580475, 15834.366625335088, 15835.366585336687, 12645.178063426032, 12647.620571382873, 12657.746845063048, 12663.49346026167, 12667.239965602093, 15237.238138093051, 15268.16025118607, 15363.692726145639, 15367.0, 15464.690706186038, 5922.7927022554, 5969.462748352669, 6017.669028203491, 6042.093685947055, 6126.417990290915, 1073.581303291717, 1084.1922767538235, 1101.4712937789907, 1105.5412004018403, 1106.5463160104318, 24510.87744561266, 24723.381915452257, 24967.0, 25000.4999900001, 25075.749242507707, 1191.737817680109, 1212.7938250497436, 1216.1486959128645, 1228.6744012836605, 1229.244014930829, 13198.14212076212, 13211.40548675312, 13433.26117063571, 13436.932815336057, 13454.46182152703, 273982.0, 277560.0, 277656.0, 278179.0, 278572.0, 63058.684706576176, 63085.0, 63105.053424198675, 63483.36516634867, 63661.68169159124, 1533.8619524242872, 1537.4695729973364, 1550.4263422533734, 1562.5312406278072, 1572.0960447742593, 29851.0, 30146.397072058873, 30156.547651784804, 30438.543421848248, 30891.536626950165, 54820.17769733378, 55752.16371754508, 55782.0, 55891.72054139703, 56065.0, 235465.0, 236272.0, 236712.0, 236783.0, 237528.0, 34816.825915871275, 35614.465783013795, 36855.44716829196, 37230.0, 37521.06197345088, 48891.75554122207, 50195.498045019085, 50661.49338506715, 50929.49070509396, 51302.230466542285, 33518.49722254119, 34765.30469390649, 35497.0, 35760.821195893855, 36295.54817807258, 34111.317773644885, 34784.30431391409, 34887.825560872036, 35143.297134057684, 35635.0, 41824.0, 42201.36697949595, 42266.1546769069, 42468.36297455479, 42481.57518424776, 34659.30681386308, 34797.0, 35146.0, 35278.11804704903, 35396.541562190985, 25462.618060729474, 26354.736452635996, 26383.076592319943, 26889.462210756068, 26897.0], "value": 18532.229031002615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1640497456303, 559.9888002239956, 568.093890245059, 568.8435680187949, 585.5842351930129, 22981.655275170844, 23242.65136022961, 24022.0, 24174.274771756853, 24192.395190120256, 26784.866075669644, 26904.730952690516, 26937.595936060974, 26947.461050778973, 26967.730322696818, 6096.969515152429, 6242.219722534684, 6266.905996410034, 6268.310485846553, 6268.686565671721, 5971.581989260753, 6242.937570624281, 6245.375462453741, 6261.624302541862, 6265.843353916143, 6219.440250377465, 6220.875582488347, 6223.377662233763, 6224.066390041485, 6242.781502647408, 6191.938080619204, 6200.751969921198, 6217.409346112112, 6224.6887655617265, 6230.87538249237, 5744.741486633112, 5777.19119323295, 5786.450287222707, 5794.884102317972, 5795.391483894173, 28036.299092522648, 30601.234969125726, 31142.065738027897, 31144.0, 31315.843420782978, 2155.7628660847295, 2184.6722991551237, 2199.604071267171, 2201.3836125884777, 2201.460642142685, 19691.310804121786, 20011.699824502644, 20065.799342006685, 20112.195512179496, 20113.793172409703, 2343.871087090209, 2344.4724936889234, 2421.067888862783, 2429.3683642252963, 2459.86470744109, 150139.0, 152885.23557382255, 152979.0, 153064.234678827, 154065.99999999886, 14730.317420644838, 15070.321835517429, 15143.318550665246, 15328.386864525517, 15749.212539372986, 23162.3051308461, 23188.536229275658, 23255.651165232535, 23271.06915723386, 24057.639135412985, 10195.7451063724, 10254.333468324536, 10307.74230644225, 10319.587216511405, 10381.740456488647, 9314.301427392973, 9403.341766076446, 9415.62337506492, 9447.291453141042, 9550.331476796557, 9407.78916954515, 9464.574094165779, 9669.419834809934, 9854.802903941882, 9979.151772099307, 2641.141628970592, 2717.293503689055, 2724.850133242691, 2791.1207969489546, 2934.3544420227518, 1030.845373194027, 1038.2109596706557, 1042.5204405973186, 1057.9100776434088, 1070.9089727373105, 20918.47703807417, 21181.470463238544, 21841.453963650718, 22227.222047228268, 26249.868750656125, 1076.8169411200115, 1091.5415525479318, 1097.7639807441278, 1110.2394859521253, 1116.6370929447962, 11297.604583839526, 12030.27818330903, 12160.027197824153, 12172.81740773889, 12228.388580570936, 580616.0, 607792.0, 608031.0, 610545.0, 614575.0, 130244.0, 133034.0, 136074.31962840122, 136962.0, 138605.0, 1281.9743605127844, 1290.1291628150962, 1319.6700824793802, 1320.735852829438, 1322.2793577500286, 19077.71383429222, 20252.79747202568, 21597.676034859804, 23554.528909422057, 23702.762972370747, 64758.676206618664, 65335.67332163309, 65411.34588654053, 66965.3303466959, 67369.3263067363, 79322.6033869827, 79418.2058179434, 79430.0, 79988.0, 80127.59936200282, 14891.0, 15090.622734431727, 15416.152111633968, 15438.073715577102, 15619.297131628877, 24400.0, 24465.87767061153, 24725.258242252043, 24948.750512494644, 24952.875235623706, 19594.510137246114, 19816.0, 19933.700994485385, 20195.899020504803, 20199.8990005049, 17180.0, 17499.56251093733, 17630.82369176343, 17675.29298828084, 18108.637827243117, 20083.19667213295, 20147.899260503604, 20309.390718278475, 20316.79683203149, 20399.59200816005, 15191.77212341838, 15237.3905043797, 15333.619974202375, 15337.6165595861, 15376.846231537542, 19365.225390984204, 19448.0, 19469.0, 19486.8051319485, 19984.300549480697], "value": 12614.321826109155, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.2582789388584, 1443.9927800360997, 1452.9854701452982, 1464.7070585882825, 1487.390170030288, 14818.333175007123, 15498.845011549894, 15538.145402002885, 15629.218539073057, 15636.0, 15935.920320398382, 16175.35298588055, 16180.595485112877, 16189.595260118473, 16194.433194838153, 2661.4943160799435, 2714.538528450168, 2729.727027297264, 2734.808563400563, 2745.0, 2675.0, 2786.080593404182, 2788.679301880279, 2788.776897848177, 2791.3579876628387, 2750.724927507253, 2761.3648860761937, 2768.4463107378506, 2770.044334704524, 2781.4993301205773, 2637.5384307746067, 2648.3776312566533, 2662.8402295862115, 2669.412729199573, 2678.2367025397766, 2584.5606246938064, 2595.2473782603024, 2610.151700697281, 2627.54018046841, 2632.565626671597, 15184.46854360092, 15509.457168999144, 15515.612109697235, 15543.14512701801, 15574.065556066558, 7807.0, 8114.148014458456, 8134.918650813475, 8138.104808471064, 8140.552269625168, 5022.4726403727445, 5100.770465329069, 5162.380514338303, 5184.351956005499, 5270.578353731692, 1774.946751597454, 1777.5378401615544, 1783.8929664220188, 1814.5463634091477, 1821.6447792680433, 27166.5925011125, 27250.31874203141, 27497.0, 27501.862490687618, 27501.862490687618, 6638.402543770987, 6682.799516014527, 6870.519063665495, 6893.586384816927, 6943.652817359213, 18193.63612727738, 18330.0, 18342.724859127124, 18345.816541834676, 18366.449006529827, 7897.407694422941, 8178.918210817935, 8185.754427367188, 8186.222308880647, 8189.79525511867, 7431.591262480507, 7445.143808461988, 7546.320831125225, 7583.544987300779, 7584.0, 5251.947480525222, 5450.427705090988, 5476.0, 5513.117901135879, 5520.779168833282, 1580.4310448238625, 1581.549258461333, 1582.8021497312836, 1587.952361429159, 1616.2080580515462, 861.1560670542904, 871.8387098386819, 882.8787439951354, 902.6840605787921, 911.2709832134266, 7767.18444563324, 8986.370954033155, 9052.81894362109, 9201.0, 9236.5843537041, 971.455984648599, 972.2562239886493, 1015.3958394755109, 1026.9948650256702, 1032.256775121911, 4660.953390466119, 4999.325091112726, 4999.450060493343, 5197.870053248699, 5279.234510995884, 20731.27440539604, 21310.467238319165, 21893.67159492609, 21945.451363716034, 22131.446713832283, 21670.0, 21686.566268674538, 21688.24091156802, 21802.454938626663, 21841.344759657237, 11089.445527723581, 11893.226940248856, 12026.879731202751, 12090.69773255658, 12105.09211809118, 7657.119431265476, 7981.161977992228, 8094.797630059295, 8148.470349427268, 8176.182381761776, 18373.17320720544, 18477.53806154857, 18873.150708218436, 19553.315633952745, 19601.70597441011, 18878.905605471886, 19140.8085919139, 19197.520061998002, 19823.30618428348, 19950.90024549868, 11566.65300041, 11593.0, 11672.0, 11718.121140914294, 11852.585159519376, 14364.784528231876, 14367.425302988182, 14485.565433037025, 14511.1293322401, 14515.274236288355, 10701.51843167075, 11201.43992800373, 11215.19594135733, 11478.770424591628, 11619.6514104577, 10836.837447438136, 10917.0, 10933.56265749361, 11315.773684526428, 11392.715182120513, 8733.694320698745, 8863.02506724247, 8865.290776737975, 8866.157715017063, 8874.245689116238, 6846.418054465426, 7014.508984371045, 7103.82240443993, 7121.501494895308, 7140.892886606809, 6954.269801670752, 7293.307135822089, 7342.118945726547, 7410.481266311306, 7484.438667100098], "value": 6738.822781042184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.6602310428908, 502.314340924638, 530.2788208037066, 533.9012282727696, 534.3881255961923, 5906.497947674442, 6019.555306726387, 6080.2399700037495, 6094.634321940675, 6105.816825495237, 5858.88282234355, 5871.882562348761, 5938.554608404365, 5943.3462319144855, 5979.730912108955, 4670.112678591074, 4680.227762419206, 4684.929726054112, 4739.668223224376, 4744.952550474485, 4572.222722137245, 4690.458703678718, 4691.671582989192, 4694.225452800284, 4739.0995710815005, 4655.837045703401, 4661.86014419568, 4668.159731248374, 4685.320628508881, 4699.130660827758, 4653.418322709661, 4669.603083737852, 4673.1121086993535, 4694.812207511695, 4700.858974230744, 4217.0, 4221.831126754926, 4247.469066366704, 4278.4865816102265, 4314.6840213734795, 5837.357890632027, 5909.143174239711, 5933.792317268918, 5934.258217722785, 5941.553898738721, 5577.8047768328315, 5582.162675598693, 5586.994341018615, 5631.155326700987, 5653.180288858133, 6353.777617783356, 6360.268569114564, 6387.169667943138, 6394.328595497499, 6417.7753778617525, 4802.783874725646, 4819.783109760034, 4820.0, 4862.902741945177, 4886.14492463821, 6710.765123220664, 6711.154432531044, 6716.227633822075, 6741.426978706816, 6755.459563234929, 4960.801567937242, 4965.3048573199785, 4969.378827646544, 4972.801087956514, 4974.27872958419, 5061.493850614983, 5064.7214403207445, 5076.543111120017, 5077.289179514871, 5086.669366491166, 5568.860778480489, 5586.664800111925, 5613.073842815889, 5649.745761440745, 5652.0, 6206.534509911684, 6421.903671444932, 6442.291347951722, 6449.32282110381, 6478.643674597943, 1679.2863033210836, 1686.3844696685621, 1710.9306683322923, 1711.512219017599, 1727.1709579401956, 1200.37580458163, 1218.8781121887919, 1222.10175520992, 1230.5077968812548, 1236.6537369536363, 6132.386761323832, 6140.907886381708, 6164.969175154096, 6166.876662466726, 6174.684493315007, 6483.740650373932, 6514.478841692653, 6588.287045368239, 6598.802035938929, 6627.668616569153, 6082.847928801727, 6149.3235744068115, 6161.44546990773, 6176.969115154396, 6192.256929168529, 3418.1454636340914, 3419.9487007694906, 3454.7408944329277, 3473.322702073122, 3499.702525285379, 6878.283078184189, 6936.861262774716, 6981.860362792716, 7015.473839462061, 7064.611446370396, 6632.668366581652, 6662.300458451889, 6759.560628559227, 6774.543473153197, 6849.0, 6950.992106144581, 6973.546719463218, 6976.686049127801, 6989.580625162506, 6995.545289556163, 6506.681592387821, 6521.934780652323, 6593.967030164818, 6620.271770105381, 6642.767503137367, 6433.517486188648, 6531.477481801539, 6550.83622909412, 6568.638724870178, 6573.474122070318, 6840.384365407137, 6844.760433384808, 6849.1438570178725, 6870.45036397097, 6921.89617155733, 4921.188003979303, 4929.802807887788, 4937.086638971802, 4943.824717124454, 4958.355413796184, 6414.61512309263, 6541.509386796104, 6549.770758023446, 6586.868262634816, 6660.234073081658, 6215.285242197205, 6268.404501572343, 6268.623882567061, 6335.144755458138, 6358.936410635834, 6237.625742455467, 6253.437190652863, 6317.778877739257, 6345.206849143857, 6372.936270637234, 6252.531060170596, 6269.185005949197, 6335.968320158369, 6351.841203969753, 6357.650329231937, 6207.720652570735, 6278.434940855345, 6305.873882522232, 6338.890694128601, 6420.1974753155855, 6136.4658835291175, 6186.350433204449, 6188.690565471798, 6249.562530622813, 6253.562250642593], "value": 4984.574797128171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [943.9811203775929, 949.5726922884703, 962.0523784072687, 965.9471176417703, 979.0796651147921, 18699.43901682948, 19586.804131958677, 19608.019599020063, 19648.21407143714, 20785.0, 19729.506762330948, 19760.0, 19900.60198796023, 19917.502062448446, 19975.200991960304, 1042.0569384706835, 1043.2801367056707, 1046.3198920701566, 1053.073295499959, 1053.4469403563114, 1002.4185972136144, 1064.0211005874614, 1064.9946750266238, 1065.5897479470382, 1068.4230515521608, 978.2076518020391, 1092.0335503079752, 1097.286763603656, 1100.8403781451684, 1101.8843021482749, 1019.94390308533, 1094.179365475893, 1095.9232853700244, 1096.6326280695976, 1098.1818545183849, 804.1476035402492, 805.4844899264475, 808.9352851771844, 813.3777660090036, 813.6826637611337, 19186.0, 19793.604127917504, 19935.90032049845, 19991.80008199914, 20286.69569956452, 20830.0, 21070.0, 21296.0, 21424.678629820566, 21683.34949951504, 14941.701165976729, 15212.011219270711, 15250.466233681767, 15330.770038449433, 15374.538763837103, 3555.484454754046, 3618.0412190769202, 3625.728070394731, 3626.2203626220225, 3630.764000339996, 132070.7404632118, 134249.3287533566, 137631.31184344113, 139441.0, 139494.30252848772, 13357.599272021855, 13918.860811391958, 14113.717725645429, 14218.146911185362, 14406.783898241534, 29544.704552954194, 29562.704372956425, 29828.701712983027, 29883.0, 30356.026858254143, 7982.521048737094, 8216.0, 8272.83454330922, 8569.314454843598, 8663.393562450694, 4404.383386325917, 4512.481064677539, 4512.887177820581, 4529.184746745617, 4540.137373898949, 5230.137027390514, 5337.626366154332, 5368.651037682538, 5569.805056823073, 5831.825045248649, 1195.1992165249303, 1202.2786328203008, 1219.1587804414926, 1220.7863623865787, 1222.896053835434, 705.7177129148279, 705.8870580707062, 712.9144502659714, 732.4945787406672, 741.1587847792687, 12599.0, 13871.861281387259, 14438.566842994727, 14448.277586120652, 14499.92750036243, 711.6512908674815, 727.1782885339533, 746.268656716421, 746.302207436049, 763.2863272839912, 5687.43125687428, 5749.453801888814, 5760.164776107441, 5786.94213057864, 5890.204822348928, 127518.36240818737, 129100.0, 129490.0, 130391.34804326107, 132771.0, 113776.0, 116462.41768791272, 117416.0, 118813.40593296978, 123153.38423307826, 95856.52071739596, 99337.50331248298, 99378.50310748545, 100631.0, 100854.49572752089, 12738.554150604685, 13399.397027133997, 13640.522581709989, 13736.725265494833, 13792.0, 42327.788361057996, 44329.33505997477, 45099.0, 45309.320360195285, 46234.0, 76093.23906761083, 76546.23453765392, 79362.20637793548, 82197.58901205455, 83476.0, 18863.43409697711, 19040.1431935566, 19253.22987080501, 19478.805211948267, 19556.80443195607, 18821.153048112596, 19266.807331927062, 19279.0, 21666.566668666223, 22345.329640110824, 18077.81922180814, 18268.634627307645, 18310.0, 18348.082595869888, 18529.166187521325, 20493.38519844407, 20686.896565517076, 20724.896375518027, 20727.378178654664, 20962.790372096082, 18052.0, 18071.638567228845, 18306.26774929041, 18323.725144123116, 18557.072146392897, 13412.93293533526, 13501.257430841399, 13815.585532434043, 13908.0, 14194.858051419767, 15017.549473515812, 15125.0, 15326.157061361286, 15542.378304867678, 15547.533573992798], "value": 9598.520088873114, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 107.0, 100.0, 105.0, 104.0, 106.0, 108.0, 99.0, 106.0, 107.0], "value": 103.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 155.0, 179.0, 115.0, 139.0, 143.0, 114.0, 163.0, 121.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 161.0, 165.0, 163.0, 163.0, 165.0, 168.0, 169.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 165.0, 75.0, 76.0, 74.0, 87.0, 107.0, 76.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 140.0, 79.0, 78.0, 78.0, 135.0, 78.0, 77.0, 132.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 56.0, 50.0, 49.0, 49.0, 51.0, 48.0, 50.0, 51.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 82.0, 76.0, 75.0, 77.0, 77.0, 79.0, 78.0, 78.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 121.0, 131.0, 126.0, 117.0, 116.0, 121.0, 135.0, 160.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 183.0, 163.0, 168.0, 174.0, 168.0, 165.0, 168.0, 174.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 59.0, 64.0, 61.0, 60.0, 60.0, 60.0], "value": 61.4, "unit": "score"}]}]} 03:53:39 INFO - Return code: 0 03:53:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:39 INFO - # TBPL SUCCESS # 03:53:39 INFO - Running post-action listener: _package_coverage_data 03:53:39 INFO - Running post-action listener: _resource_record_post_action 03:53:39 INFO - [mozharness: 2017-07-31 10:53:39.120114Z] Finished run-tests step (success) 03:53:39 INFO - Running post-run listener: _resource_record_post_run 03:53:39 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 439238656; Read time: 12; Write time: 322816 03:53:39 INFO - TinderboxPrint: CPU usage
13.1% 03:53:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:53:39 INFO - TinderboxPrint: I/O write bytes / time
439,238,656 / 322,816 03:53:39 INFO - TinderboxPrint: CPU idle
8,242.8 (86.9%) 03:53:39 INFO - TinderboxPrint: CPU user
1,189.7 (12.5%) 03:53:39 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:39 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119685120; Read time: 0; Write time: 111316 03:53:39 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:53:39 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 319553536; Read time: 0; Write time: 211500 03:53:39 INFO - Running post-run listener: _upload_blobber_files 03:53:39 INFO - Blob upload gear active. 03:53:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:39 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 03:53:39 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'] 03:53:39 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 03:53:40 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:47 INFO - (blobuploader) - INFO - Done attempting. 03:53:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:48 INFO - (blobuploader) - INFO - Done attempting. 03:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:49 INFO - (blobuploader) - INFO - Done attempting. 03:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:50 INFO - (blobuploader) - INFO - Done attempting. 03:53:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:50 INFO - Return code: 0 03:53:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd6602c416d7963cdbb0257f53e1ad00fa2912a8ef55c6d64b5f4e12f5b54e86fe0c1bb96ec6379b359c67f7864c9a5a9168c9b34c04e62cddd58c90f7f6ef93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9f75e251e3980e9eee2a76a5c370fad10221d9e2938624668cf3e3f85626d01d342ef07193b91cb71d7ddead672293dd12dca27144001fcab2fb86398a4e4fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38d60a1ecee93ec5c9c67cb9f04cc807262f807ac661a781959f730f16b23500354ac1f288c3e92b69de5e341a0f4c6673374b29aade9b6fc8ed1a06c6ba3f07", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4949afe86f1e888365c1205e5c6b42ccd82204533e5dceea1bc7e49ac993ca042af2df6246ff12e6b95936096687c17bfe53db44184f55c455e40cecc6f107e5"} 03:53:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:50 INFO - Contents: 03:53:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd6602c416d7963cdbb0257f53e1ad00fa2912a8ef55c6d64b5f4e12f5b54e86fe0c1bb96ec6379b359c67f7864c9a5a9168c9b34c04e62cddd58c90f7f6ef93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9f75e251e3980e9eee2a76a5c370fad10221d9e2938624668cf3e3f85626d01d342ef07193b91cb71d7ddead672293dd12dca27144001fcab2fb86398a4e4fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38d60a1ecee93ec5c9c67cb9f04cc807262f807ac661a781959f730f16b23500354ac1f288c3e92b69de5e341a0f4c6673374b29aade9b6fc8ed1a06c6ba3f07", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4949afe86f1e888365c1205e5c6b42ccd82204533e5dceea1bc7e49ac993ca042af2df6246ff12e6b95936096687c17bfe53db44184f55c455e40cecc6f107e5"} 03:53:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:50 INFO - Copying logs to upload dir... 03:53:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.537086 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-31 03:53:50.115219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 03:53:50.118546) ========= 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=3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208 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/dd6602c416d7963cdbb0257f53e1ad00fa2912a8ef55c6d64b5f4e12f5b54e86fe0c1bb96ec6379b359c67f7864c9a5a9168c9b34c04e62cddd58c90f7f6ef93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9f75e251e3980e9eee2a76a5c370fad10221d9e2938624668cf3e3f85626d01d342ef07193b91cb71d7ddead672293dd12dca27144001fcab2fb86398a4e4fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38d60a1ecee93ec5c9c67cb9f04cc807262f807ac661a781959f730f16b23500354ac1f288c3e92b69de5e341a0f4c6673374b29aade9b6fc8ed1a06c6ba3f07", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4949afe86f1e888365c1205e5c6b42ccd82204533e5dceea1bc7e49ac993ca042af2df6246ff12e6b95936096687c17bfe53db44184f55c455e40cecc6f107e5"} build_url:https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/YRC8Ej07S6aB7aYErhWsJw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd6602c416d7963cdbb0257f53e1ad00fa2912a8ef55c6d64b5f4e12f5b54e86fe0c1bb96ec6379b359c67f7864c9a5a9168c9b34c04e62cddd58c90f7f6ef93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9f75e251e3980e9eee2a76a5c370fad10221d9e2938624668cf3e3f85626d01d342ef07193b91cb71d7ddead672293dd12dca27144001fcab2fb86398a4e4fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38d60a1ecee93ec5c9c67cb9f04cc807262f807ac661a781959f730f16b23500354ac1f288c3e92b69de5e341a0f4c6673374b29aade9b6fc8ed1a06c6ba3f07", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4949afe86f1e888365c1205e5c6b42ccd82204533e5dceea1bc7e49ac993ca042af2df6246ff12e6b95936096687c17bfe53db44184f55c455e40cecc6f107e5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 03:53:50.143373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:53:50.143710) ========= 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=3836458cccd887f2d2de3cf1000001de-1501497173.70173-591867208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004349 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:53:50.229140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:53:50.229446) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:53:50.229727) ========= ========= Total master_lag: 0.20 =========