summaryrefslogtreecommitdiff
path: root/integrationtests/dcatcolors.server.expected
diff options
context:
space:
mode:
authorPaul Buetow <paul@buetow.org>2026-07-22 23:51:28 +0300
committerPaul Buetow <paul@buetow.org>2026-07-22 23:51:28 +0300
commitbc2767c87c4090798c4c7d15e101ed066e947301 (patch)
tree0f47a2e0b159a617eb56509bbca1c998196453c4 /integrationtests/dcatcolors.server.expected
parent849951be1d1a7ee9f9302006ccb187bf5b4e36f3 (diff)
test: DTail fork — integration test suite and fixtures
Squashed development of the integration test suite (integrationtests/) covering DCat, DGrep, DMap (serverless + server mode), DTail follow, DServer, DTailHealth, journal source reads, auth-key fast reconnect, interactive query reload, client-deadline/timeout behaviour, and the single-mode read/output path. Includes real test fixtures (dserver*.cfg, dmap_csv_multifile_*.csv.in, test_server_*.json, *.expected golden files) and deterministic synchronization helpers (waitContains-style barriers) replacing racy fixed-timing assertions. Accidental debug/output dumps that earlier commits added here (captured client output, strace logs, ad-hoc turbo_test_output/manual_output/test_output files, throwaway debug scripts) are intentionally excluded and gitignored. Co-Authored-By: Claude Opus 4.8 <noreply@anthropic.com>
Diffstat (limited to 'integrationtests/dcatcolors.server.expected')
-rw-r--r--integrationtests/dcatcolors.server.expected2754
1 files changed, 2754 insertions, 0 deletions
diff --git a/integrationtests/dcatcolors.server.expected b/integrationtests/dcatcolors.server.expected
new file mode 100644
index 0000000..a6afae2
--- /dev/null
+++ b/integrationtests/dcatcolors.server.expected
@@ -0,0 +1,2754 @@
+REMOTE|integrationtest|100|1|dcatcolors.txt|FATAL|20211015-053919|SSH relaxed-auth mode enabled
+REMOTE|integrationtest|100|2|dcatcolors.txt|INFO|20211015-053919|Creating server|DTail 4.0.0-RC1 Protocol 4 Have a lot of fun!
+REMOTE|integrationtest|100|3|dcatcolors.txt|INFO|20211015-053919|Generating private server RSA host key
+REMOTE|integrationtest|100|4|dcatcolors.txt|ERROR|20211015-053919|Unable to write private server RSA host key to file|cache/ssh_host_key|open cache/ssh_host_key: no such file or directory
+REMOTE|integrationtest|100|5|dcatcolors.txt|INFO|20211015-053919|Starting server
+REMOTE|integrationtest|100|6|dcatcolors.txt|INFO|20211015-053919|Binding server|0.0.0.0:2222
+REMOTE|integrationtest|100|7|dcatcolors.txt|DEBUG|20211015-053919|Starting listener loop
+REMOTE|integrationtest|100|8|dcatcolors.txt|INFO|20211015-053919|Starting continuous job runner after 10s
+REMOTE|integrationtest|100|9|dcatcolors.txt|INFO|20211015-053919|Starting scheduled job runner after 10s
+REMOTE|integrationtest|100|10|dcatcolors.txt|INFO|20211015-053926|Handling connection
+REMOTE|integrationtest|100|11|dcatcolors.txt|INFO|20211015-053928|paul@172.17.0.1:33710|Incoming authorization
+REMOTE|integrationtest|100|12|dcatcolors.txt|FATAL|20211015-053928|paul@172.17.0.1:33710|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|13|dcatcolors.txt|INFO|20211015-053928|1|stats.go:53|8|16|7|1.34|781h28m6s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=1
+REMOTE|integrationtest|100|14|dcatcolors.txt|INFO|20211015-053928|paul@172.17.0.1:33710|Invoking channel handler
+REMOTE|integrationtest|100|15|dcatcolors.txt|INFO|20211015-053928|paul@172.17.0.1:33710|Invoking request handler
+REMOTE|integrationtest|100|16|dcatcolors.txt|DEBUG|20211015-053928|paul@172.17.0.1:33710|Creating new server handler
+REMOTE|integrationtest|100|17|dcatcolors.txt|DEBUG|20211015-053928|paul@172.17.0.1:33710|protocol 4 base64 dGFpbDogL3Zhci9sb2cvZHNlcnZlci8qIHJlZ2V4Om5vb3Ag
+REMOTE|integrationtest|100|18|dcatcolors.txt|TRACE|20211015-053928|paul@172.17.0.1:33710|Base64 decoded received command|tail: /var/log/dserver/* regex:noop |36|[tail: /var/log/dserver/* regex:noop ]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|19|dcatcolors.txt|DEBUG|20211015-053928|paul@172.17.0.1:33710|Handling user command|36|[tail: /var/log/dserver/* regex:noop ]
+REMOTE|integrationtest|100|20|dcatcolors.txt|DEBUG|20211015-053928|paul@172.17.0.1:33710|/var/log/dserver/dserver.log|readfiles|Checking config permissions
+REMOTE|integrationtest|100|21|dcatcolors.txt|FATAL|20211015-053928|paul@172.17.0.1:33710|/var/log/dserver/dserver.log|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|22|dcatcolors.txt|INFO|20211015-053928|paul@172.17.0.1:33710|Start reading file|/var/log/dserver/dserver.log|dserver.log
+REMOTE|integrationtest|100|23|dcatcolors.txt|DEBUG|20211015-053928|readFile|readFile(filePath:/var/log/dserver/dserver.log,globID:dserver.log,retry:true,canSkipLines:true,seekEOF:true)
+REMOTE|integrationtest|100|24|dcatcolors.txt|INFO|20211015-053929|1|stats.go:53|8|26|7|1.34|781h28m7s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=1
+REMOTE|integrationtest|100|25|dcatcolors.txt|DEBUG|20211015-053931|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|26|dcatcolors.txt|DEBUG|20211015-053934|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|27|dcatcolors.txt|DEBUG|20211015-053937|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|28|dcatcolors.txt|INFO|20211015-053939|1|stats.go:53|8|16|7|1.21|781h28m16s|MAPREDUCE:STATS|lifetimeConnections=1|currentConnections=0
+REMOTE|integrationtest|100|29|dcatcolors.txt|INFO|20211015-053939|paul@172.17.0.1:33710|Good bye Mister!
+REMOTE|integrationtest|100|30|dcatcolors.txt|DEBUG|20211015-053939|paul@172.17.0.1:33710|shutdown()
+REMOTE|integrationtest|100|31|dcatcolors.txt|TRACE|20211015-053939|paul@172.17.0.1:33710|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|32|dcatcolors.txt|DEBUG|20211015-053939|paul@172.17.0.1:33710|ALL lines sent|0xc0002aa000
+REMOTE|integrationtest|100|33|dcatcolors.txt|INFO|20211015-053939|1|stats.go:53|8|11|7|1.21|781h28m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=1
+REMOTE|integrationtest|100|34|dcatcolors.txt|INFO|20211015-053942|Handling connection
+REMOTE|integrationtest|100|35|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:33712|Incoming authorization
+REMOTE|integrationtest|100|36|dcatcolors.txt|FATAL|20211015-053942|paul@172.17.0.1:33712|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|37|dcatcolors.txt|INFO|20211015-053942|1|stats.go:53|8|15|7|1.11|781h28m19s|MAPREDUCE:STATS|lifetimeConnections=2|currentConnections=1
+REMOTE|integrationtest|100|38|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:33712|Invoking channel handler
+REMOTE|integrationtest|100|39|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:33712|Invoking request handler
+REMOTE|integrationtest|100|40|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:33712|Creating new server handler
+REMOTE|integrationtest|100|41|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:33712|protocol 4 base64 Y2F0OiAvZXRjL3Bhc3N3ZCByZWdleDpub29wIA==
+REMOTE|integrationtest|100|42|dcatcolors.txt|TRACE|20211015-053942|paul@172.17.0.1:33712|Base64 decoded received command|cat: /etc/passwd regex:noop |28|[cat: /etc/passwd regex:noop ]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|43|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:33712|Handling user command|28|[cat: /etc/passwd regex:noop ]
+REMOTE|integrationtest|100|44|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:33712|/etc/passwd|readfiles|Checking config permissions
+REMOTE|integrationtest|100|45|dcatcolors.txt|FATAL|20211015-053942|paul@172.17.0.1:33712|/etc/passwd|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|46|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:33712|Start reading file|/etc/passwd|passwd
+REMOTE|integrationtest|100|47|dcatcolors.txt|DEBUG|20211015-053942|readFile|readFile(filePath:/etc/passwd,globID:passwd,retry:false,canSkipLines:false,seekEOF:false)
+REMOTE|integrationtest|100|48|dcatcolors.txt|INFO|20211015-053942|/etc/passwd|End of file reached
+REMOTE|integrationtest|100|49|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:33712|shutdown()
+REMOTE|integrationtest|100|50|dcatcolors.txt|TRACE|20211015-053942|paul@172.17.0.1:33712|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|51|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:33712|Still lines to be sent
+REMOTE|integrationtest|100|52|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:33712|ALL lines sent|0xc0002aa0e0
+REMOTE|integrationtest|100|53|dcatcolors.txt|INFO|20211015-053942|1|stats.go:53|8|21|7|1.11|781h28m19s|MAPREDUCE:STATS|lifetimeConnections=2|currentConnections=0
+REMOTE|integrationtest|100|54|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:33712|Good bye Mister!
+REMOTE|integrationtest|100|55|dcatcolors.txt|INFO|20211015-053949|Handling connection
+REMOTE|integrationtest|100|56|dcatcolors.txt|INFO|20211015-053949|paul@172.17.0.1:33714|Incoming authorization
+REMOTE|integrationtest|100|57|dcatcolors.txt|FATAL|20211015-053949|paul@172.17.0.1:33714|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|58|dcatcolors.txt|INFO|20211015-053949|1|stats.go:53|8|15|7|1.10|781h28m26s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=3
+REMOTE|integrationtest|100|59|dcatcolors.txt|INFO|20211015-053949|paul@172.17.0.1:33714|Invoking channel handler
+REMOTE|integrationtest|100|60|dcatcolors.txt|INFO|20211015-053949|paul@172.17.0.1:33714|Invoking request handler
+REMOTE|integrationtest|100|61|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:33714|Creating new server handler
+REMOTE|integrationtest|100|62|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:33714|protocol 4 base64 bWFwIGZyb20gc3RhdHMgc2VsZWN0IGF2ZygkZ29yb3V0aW5lcyksbWF4KCRnb3JvdXRpbmVzKSxtaW4oJGdvcm91dGluZXMpLGxhc3QoJGdvcm91dGluZXMpLGNvdW50KCRob3N0bmFtZSksJGhvc3RuYW1lIGdyb3VwIGJ5ICRob3N0bmFtZSBvcmRlciBieSBhdmcoJGdvcm91dGluZXMp
+REMOTE|integrationtest|100|63|dcatcolors.txt|TRACE|20211015-053949|paul@172.17.0.1:33714|Base64 decoded received command|map from stats select avg($goroutines),max($goroutines),min($goroutines),last($goroutines),count($hostname),$hostname group by $hostname order by avg($goroutines)|162|[map from stats select avg($goroutines),max($goroutines),min($goroutines),last($goroutines),count($hostname),$hostname group by $hostname order by avg($goroutines)]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|64|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:33714|Handling user command|162|[map from stats select avg($goroutines),max($goroutines),min($goroutines),last($goroutines),count($hostname),$hostname group by $hostname order by avg($goroutines)]
+REMOTE|integrationtest|100|65|dcatcolors.txt|INFO|20211015-053949|Creating log format parser|default
+REMOTE|integrationtest|100|66|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:33714|protocol 4 base64 Y2F0OiAvdmFyL2xvZy9kc2VydmVyLyogcmVnZXg6ZGVmYXVsdCBcfE1BUFJFRFVDRTpTVEFUU1x8
+REMOTE|integrationtest|100|67|dcatcolors.txt|TRACE|20211015-053949|paul@172.17.0.1:33714|Base64 decoded received command|cat: /var/log/dserver/* regex:default \|MAPREDUCE:STATS\||57|[cat: /var/log/dserver/* regex:default \|MAPREDUCE:STATS\|]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|68|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:33714|Handling user command|57|[cat: /var/log/dserver/* regex:default \|MAPREDUCE:STATS\|]
+REMOTE|integrationtest|100|69|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:33714|/var/log/dserver/dserver.log|readfiles|Checking config permissions
+REMOTE|integrationtest|100|70|dcatcolors.txt|FATAL|20211015-053949|paul@172.17.0.1:33714|/var/log/dserver/dserver.log|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|71|dcatcolors.txt|INFO|20211015-053949|paul@172.17.0.1:33714|Start reading file|/var/log/dserver/dserver.log|dserver.log
+REMOTE|integrationtest|100|72|dcatcolors.txt|DEBUG|20211015-053949|readFile|readFile(filePath:/var/log/dserver/dserver.log,globID:dserver.log,retry:false,canSkipLines:false,seekEOF:false)
+REMOTE|integrationtest|100|73|dcatcolors.txt|INFO|20211015-053949|/var/log/dserver/dserver.log|End of file reached
+REMOTE|integrationtest|100|74|dcatcolors.txt|INFO|20211015-053949|Serializing mapreduce result
+REMOTE|integrationtest|100|75|dcatcolors.txt|TRACE|20211015-053949|Serialising mapr.AggregateSet|AggregateSet(Samples:7,FValues:map[avg($goroutines):120 count($hostname):7 max($goroutines):26 min($goroutines):11],SValues:map[$hostname:serv6 last($goroutines):15])|at /home/paul/git/dtail/internal/mapr/aggregateset.go:72
+REMOTE|integrationtest|100|76|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:33714|shutdown()
+REMOTE|integrationtest|100|77|dcatcolors.txt|TRACE|20211015-053949|paul@172.17.0.1:33714|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|78|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:33714|ALL lines sent|0xc0004f0000
+REMOTE|integrationtest|100|79|dcatcolors.txt|INFO|20211015-053949|1|stats.go:53|8|13|7|1.10|781h28m26s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=3
+REMOTE|integrationtest|100|80|dcatcolors.txt|INFO|20211015-053949|paul@172.17.0.1:33714|Good bye Mister!
+REMOTE|integrationtest|100|81|dcatcolors.txt|INFO|20211015-053949|1|stats.go:53|8|12|7|1.10|781h28m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=3
+REMOTE|integrationtest|100|82|dcatcolors.txt|INFO|20211015-053959|1|stats.go:53|8|11|7|1.01|781h28m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=3
+REMOTE|integrationtest|100|83|dcatcolors.txt|INFO|20211015-054002|Handling connection
+REMOTE|integrationtest|100|84|dcatcolors.txt|INFO|20211015-054002|paul@172.17.0.1:33716|Incoming authorization
+REMOTE|integrationtest|100|85|dcatcolors.txt|FATAL|20211015-054002|paul@172.17.0.1:33716|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|86|dcatcolors.txt|INFO|20211015-054002|1|stats.go:53|8|15|7|1.09|781h28m39s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=4
+REMOTE|integrationtest|100|87|dcatcolors.txt|INFO|20211015-054002|paul@172.17.0.1:33716|Invoking channel handler
+REMOTE|integrationtest|100|88|dcatcolors.txt|INFO|20211015-054002|paul@172.17.0.1:33716|Invoking request handler
+REMOTE|integrationtest|100|89|dcatcolors.txt|DEBUG|20211015-054002|paul@172.17.0.1:33716|Creating new server handler
+REMOTE|integrationtest|100|90|dcatcolors.txt|DEBUG|20211015-054002|paul@172.17.0.1:33716|protocol 4 base64 Z3JlcDogL3Zhci9sb2cvZHNlcnZlci8qIHJlZ2V4OmRlZmF1bHQgTUFQUkVEVUNF
+REMOTE|integrationtest|100|91|dcatcolors.txt|TRACE|20211015-054002|paul@172.17.0.1:33716|Base64 decoded received command|grep: /var/log/dserver/* regex:default MAPREDUCE|48|[grep: /var/log/dserver/* regex:default MAPREDUCE]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|92|dcatcolors.txt|DEBUG|20211015-054002|paul@172.17.0.1:33716|Handling user command|48|[grep: /var/log/dserver/* regex:default MAPREDUCE]
+REMOTE|integrationtest|100|93|dcatcolors.txt|DEBUG|20211015-054002|paul@172.17.0.1:33716|/var/log/dserver/dserver.log|readfiles|Checking config permissions
+REMOTE|integrationtest|100|94|dcatcolors.txt|FATAL|20211015-054002|paul@172.17.0.1:33716|/var/log/dserver/dserver.log|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|95|dcatcolors.txt|INFO|20211015-054002|paul@172.17.0.1:33716|Start reading file|/var/log/dserver/dserver.log|dserver.log
+REMOTE|integrationtest|100|96|dcatcolors.txt|DEBUG|20211015-054002|readFile|readFile(filePath:/var/log/dserver/dserver.log,globID:dserver.log,retry:false,canSkipLines:false,seekEOF:false)
+REMOTE|integrationtest|100|97|dcatcolors.txt|INFO|20211015-054002|/var/log/dserver/dserver.log|End of file reached
+REMOTE|integrationtest|100|98|dcatcolors.txt|DEBUG|20211015-054002|paul@172.17.0.1:33716|shutdown()
+REMOTE|integrationtest|100|99|dcatcolors.txt|TRACE|20211015-054002|paul@172.17.0.1:33716|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|100|dcatcolors.txt|DEBUG|20211015-054002|paul@172.17.0.1:33716|Still lines to be sent
+REMOTE|integrationtest|100|101|dcatcolors.txt|DEBUG|20211015-054002|paul@172.17.0.1:33716|ALL lines sent|0xc0004f00e0
+REMOTE|integrationtest|100|102|dcatcolors.txt|ERROR|20211015-054002|paul@172.17.0.1:33716|read tcp 172.17.0.8:2222->172.17.0.1:33716: use of closed network connection
+REMOTE|integrationtest|100|103|dcatcolors.txt|INFO|20211015-054002|1|stats.go:53|8|15|7|1.09|781h28m39s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|104|dcatcolors.txt|INFO|20211015-054002|paul@172.17.0.1:33716|Good bye Mister!
+REMOTE|integrationtest|100|105|dcatcolors.txt|INFO|20211015-054009|1|stats.go:53|8|11|7|1.00|781h28m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|106|dcatcolors.txt|INFO|20211015-054019|1|stats.go:53|8|11|7|1.01|781h28m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|107|dcatcolors.txt|INFO|20211015-054029|1|stats.go:53|8|11|7|0.85|781h29m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|108|dcatcolors.txt|INFO|20211015-054039|1|stats.go:53|8|11|7|0.87|781h29m17s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|109|dcatcolors.txt|INFO|20211015-054049|1|stats.go:53|8|11|7|0.73|781h29m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|110|dcatcolors.txt|INFO|20211015-054059|1|stats.go:53|8|11|7|0.70|781h29m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|111|dcatcolors.txt|INFO|20211015-054109|1|stats.go:53|8|11|7|0.59|781h29m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|112|dcatcolors.txt|INFO|20211015-054119|1|stats.go:53|8|11|7|0.66|781h29m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|113|dcatcolors.txt|INFO|20211015-054129|1|stats.go:53|8|11|7|0.56|781h30m7s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|114|dcatcolors.txt|INFO|20211015-054139|1|stats.go:53|8|11|7|0.55|781h30m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|115|dcatcolors.txt|INFO|20211015-054149|1|stats.go:53|8|11|7|0.54|781h30m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|116|dcatcolors.txt|INFO|20211015-054159|1|stats.go:53|8|11|7|0.53|781h30m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|117|dcatcolors.txt|INFO|20211015-054209|1|stats.go:53|8|11|7|0.68|781h30m47s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|118|dcatcolors.txt|INFO|20211015-054219|1|stats.go:53|8|11|7|0.65|781h30m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|119|dcatcolors.txt|INFO|20211015-054229|1|stats.go:53|8|11|7|0.70|781h31m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|120|dcatcolors.txt|INFO|20211015-054239|1|stats.go:53|8|11|7|0.75|781h31m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|121|dcatcolors.txt|INFO|20211015-054249|1|stats.go:53|8|11|7|0.87|781h31m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|122|dcatcolors.txt|INFO|20211015-054259|1|stats.go:53|8|11|7|0.89|781h31m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|123|dcatcolors.txt|INFO|20211015-054309|1|stats.go:53|8|11|7|0.90|781h31m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|124|dcatcolors.txt|INFO|20211015-054319|1|stats.go:53|8|11|7|0.92|781h31m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|125|dcatcolors.txt|INFO|20211015-054329|1|stats.go:53|8|11|7|0.78|781h32m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|126|dcatcolors.txt|INFO|20211015-054339|1|stats.go:53|8|11|7|0.66|781h32m17s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|127|dcatcolors.txt|INFO|20211015-054349|1|stats.go:53|8|11|7|0.78|781h32m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|128|dcatcolors.txt|INFO|20211015-054359|1|stats.go:53|8|11|7|0.82|781h32m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|129|dcatcolors.txt|INFO|20211015-054409|1|stats.go:53|8|11|7|0.69|781h32m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|130|dcatcolors.txt|INFO|20211015-054419|1|stats.go:53|8|11|7|0.81|781h32m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|131|dcatcolors.txt|INFO|20211015-054429|1|stats.go:53|8|11|7|0.77|781h33m7s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|132|dcatcolors.txt|INFO|20211015-054439|1|stats.go:53|8|11|7|0.65|781h33m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|133|dcatcolors.txt|INFO|20211015-054449|1|stats.go:53|8|11|7|0.62|781h33m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|134|dcatcolors.txt|INFO|20211015-054459|1|stats.go:53|8|11|7|0.69|781h33m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|135|dcatcolors.txt|INFO|20211015-054509|1|stats.go:53|8|11|7|0.66|781h33m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|136|dcatcolors.txt|INFO|20211015-054519|1|stats.go:53|8|11|7|0.63|781h33m57s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|137|dcatcolors.txt|INFO|20211015-054529|1|stats.go:53|8|11|7|0.61|781h34m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|138|dcatcolors.txt|INFO|20211015-054539|1|stats.go:53|8|11|7|0.67|781h34m17s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|139|dcatcolors.txt|INFO|20211015-054549|1|stats.go:53|8|11|7|0.79|781h34m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|140|dcatcolors.txt|INFO|20211015-054559|1|stats.go:53|8|11|7|0.67|781h34m37s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|141|dcatcolors.txt|INFO|20211015-054609|1|stats.go:53|8|11|7|0.72|781h34m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|142|dcatcolors.txt|INFO|20211015-054619|1|stats.go:53|8|11|7|0.61|781h34m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|143|dcatcolors.txt|INFO|20211015-054629|1|stats.go:53|8|11|7|0.52|781h35m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|144|dcatcolors.txt|INFO|20211015-054639|1|stats.go:53|8|11|7|0.52|781h35m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|145|dcatcolors.txt|INFO|20211015-054649|1|stats.go:53|8|11|7|0.44|781h35m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|146|dcatcolors.txt|INFO|20211015-054659|1|stats.go:53|8|11|7|0.44|781h35m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|147|dcatcolors.txt|INFO|20211015-054709|1|stats.go:53|8|11|7|0.37|781h35m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|148|dcatcolors.txt|INFO|20211015-054719|1|stats.go:53|8|11|7|0.40|781h35m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|149|dcatcolors.txt|INFO|20211015-054729|1|stats.go:53|8|11|7|0.34|781h36m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|150|dcatcolors.txt|INFO|20211015-054739|1|stats.go:53|8|11|7|0.44|781h36m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|151|dcatcolors.txt|INFO|20211015-054749|1|stats.go:53|8|11|7|0.45|781h36m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|152|dcatcolors.txt|INFO|20211015-054759|1|stats.go:53|8|11|7|0.38|781h36m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|153|dcatcolors.txt|INFO|20211015-054809|1|stats.go:53|8|11|7|0.40|781h36m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|154|dcatcolors.txt|INFO|20211015-054819|1|stats.go:53|8|11|7|0.49|781h36m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|155|dcatcolors.txt|INFO|20211015-054829|1|stats.go:53|8|11|7|0.41|781h37m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|156|dcatcolors.txt|INFO|20211015-054839|1|stats.go:53|8|11|7|0.50|781h37m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|157|dcatcolors.txt|INFO|20211015-054849|1|stats.go:53|8|11|7|0.51|781h37m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|158|dcatcolors.txt|INFO|20211015-054859|1|stats.go:53|8|11|7|0.43|781h37m37s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|159|dcatcolors.txt|INFO|20211015-054909|1|stats.go:53|8|11|7|0.52|781h37m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|160|dcatcolors.txt|INFO|20211015-054919|1|stats.go:53|8|11|7|0.44|781h37m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|161|dcatcolors.txt|INFO|20211015-054929|1|stats.go:53|8|11|7|0.37|781h38m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|162|dcatcolors.txt|INFO|20211015-054939|1|stats.go:53|8|11|7|0.54|781h38m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|163|dcatcolors.txt|INFO|20211015-054949|1|stats.go:53|8|11|7|0.54|781h38m27s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|164|dcatcolors.txt|INFO|20211015-054959|1|stats.go:53|8|11|7|0.45|781h38m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|165|dcatcolors.txt|INFO|20211015-055009|1|stats.go:53|8|11|7|0.53|781h38m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|166|dcatcolors.txt|INFO|20211015-055019|1|stats.go:53|8|11|7|0.45|781h38m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|167|dcatcolors.txt|INFO|20211015-055030|1|stats.go:53|8|11|7|0.53|781h39m7s|MAPREDUCE:STATS|lifetimeConnections=4|currentConnections=0
+REMOTE|integrationtest|100|168|dcatcolors.txt|INFO|20211015-055040|1|stats.go:53|8|11|7|0.61|781h39m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|169|dcatcolors.txt|INFO|20211015-055050|1|stats.go:53|8|11|7|0.51|781h39m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=4
+REMOTE|integrationtest|100|170|dcatcolors.txt|INFO|20211015-055059|Handling connection
+REMOTE|integrationtest|100|171|dcatcolors.txt|INFO|20211015-055059|paul@172.17.0.1:33718|Incoming authorization
+REMOTE|integrationtest|100|172|dcatcolors.txt|FATAL|20211015-055059|paul@172.17.0.1:33718|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|173|dcatcolors.txt|INFO|20211015-055059|1|stats.go:53|8|15|7|0.58|781h39m37s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=5
+REMOTE|integrationtest|100|174|dcatcolors.txt|INFO|20211015-055059|paul@172.17.0.1:33718|Invoking channel handler
+REMOTE|integrationtest|100|175|dcatcolors.txt|INFO|20211015-055059|paul@172.17.0.1:33718|Invoking request handler
+REMOTE|integrationtest|100|176|dcatcolors.txt|DEBUG|20211015-055059|paul@172.17.0.1:33718|Creating new server handler
+REMOTE|integrationtest|100|177|dcatcolors.txt|DEBUG|20211015-055059|paul@172.17.0.1:33718|protocol 4 base64 dGFpbDogL3Zhci9sb2cvZHNlcnZlci8qIHJlZ2V4Om5vb3Ag
+REMOTE|integrationtest|100|178|dcatcolors.txt|TRACE|20211015-055059|paul@172.17.0.1:33718|Base64 decoded received command|tail: /var/log/dserver/* regex:noop |36|[tail: /var/log/dserver/* regex:noop ]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|179|dcatcolors.txt|DEBUG|20211015-055059|paul@172.17.0.1:33718|Handling user command|36|[tail: /var/log/dserver/* regex:noop ]
+REMOTE|integrationtest|100|180|dcatcolors.txt|DEBUG|20211015-055059|paul@172.17.0.1:33718|/var/log/dserver/dserver.log|readfiles|Checking config permissions
+REMOTE|integrationtest|100|181|dcatcolors.txt|FATAL|20211015-055059|paul@172.17.0.1:33718|/var/log/dserver/dserver.log|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|182|dcatcolors.txt|INFO|20211015-055059|paul@172.17.0.1:33718|Start reading file|/var/log/dserver/dserver.log|dserver.log
+REMOTE|integrationtest|100|183|dcatcolors.txt|DEBUG|20211015-055059|readFile|readFile(filePath:/var/log/dserver/dserver.log,globID:dserver.log,retry:true,canSkipLines:true,seekEOF:true)
+REMOTE|integrationtest|100|184|dcatcolors.txt|INFO|20211015-055100|1|stats.go:53|8|26|7|0.58|781h39m37s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=5
+REMOTE|integrationtest|100|185|dcatcolors.txt|DEBUG|20211015-055102|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|186|dcatcolors.txt|DEBUG|20211015-055105|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|187|dcatcolors.txt|DEBUG|20211015-055108|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|188|dcatcolors.txt|INFO|20211015-055108|1|stats.go:53|8|16|7|0.57|781h39m46s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=5
+REMOTE|integrationtest|100|189|dcatcolors.txt|INFO|20211015-055108|paul@172.17.0.1:33718|Good bye Mister!
+REMOTE|integrationtest|100|190|dcatcolors.txt|DEBUG|20211015-055108|paul@172.17.0.1:33718|shutdown()
+REMOTE|integrationtest|100|191|dcatcolors.txt|TRACE|20211015-055108|paul@172.17.0.1:33718|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|192|dcatcolors.txt|DEBUG|20211015-055108|paul@172.17.0.1:33718|ALL lines sent|0xc000198000
+REMOTE|integrationtest|100|193|dcatcolors.txt|INFO|20211015-055110|1|stats.go:53|8|11|7|0.57|781h39m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=5
+REMOTE|integrationtest|100|194|dcatcolors.txt|INFO|20211015-055120|1|stats.go:53|8|11|7|0.56|781h39m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=5
+REMOTE|integrationtest|100|195|dcatcolors.txt|INFO|20211015-055130|1|stats.go:53|8|11|7|0.48|781h40m7s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=5
+REMOTE|integrationtest|100|196|dcatcolors.txt|INFO|20211015-055140|1|stats.go:53|8|11|7|0.40|781h40m17s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=5
+REMOTE|integrationtest|100|197|dcatcolors.txt|INFO|20211015-055148|Handling connection
+REMOTE|integrationtest|100|198|dcatcolors.txt|INFO|20211015-055148|paul@172.17.0.1:33720|Incoming authorization
+REMOTE|integrationtest|100|199|dcatcolors.txt|FATAL|20211015-055148|paul@172.17.0.1:33720|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|200|dcatcolors.txt|INFO|20211015-055149|1|stats.go:53|8|15|7|0.41|781h40m26s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=6
+REMOTE|integrationtest|100|201|dcatcolors.txt|INFO|20211015-055149|paul@172.17.0.1:33720|Invoking channel handler
+REMOTE|integrationtest|100|202|dcatcolors.txt|INFO|20211015-055149|paul@172.17.0.1:33720|Invoking request handler
+REMOTE|integrationtest|100|203|dcatcolors.txt|DEBUG|20211015-055149|paul@172.17.0.1:33720|Creating new server handler
+REMOTE|integrationtest|100|204|dcatcolors.txt|DEBUG|20211015-055149|paul@172.17.0.1:33720|protocol 4 base64 Y2F0OiAvdmFyL2xvZy9kc2VydmVyLyogcmVnZXg6bm9vcCA=
+REMOTE|integrationtest|100|205|dcatcolors.txt|TRACE|20211015-055149|paul@172.17.0.1:33720|Base64 decoded received command|cat: /var/log/dserver/* regex:noop |35|[cat: /var/log/dserver/* regex:noop ]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|206|dcatcolors.txt|DEBUG|20211015-055149|paul@172.17.0.1:33720|Handling user command|35|[cat: /var/log/dserver/* regex:noop ]
+REMOTE|integrationtest|100|207|dcatcolors.txt|DEBUG|20211015-055149|paul@172.17.0.1:33720|/var/log/dserver/dserver.log|readfiles|Checking config permissions
+REMOTE|integrationtest|100|208|dcatcolors.txt|FATAL|20211015-055149|paul@172.17.0.1:33720|/var/log/dserver/dserver.log|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|209|dcatcolors.txt|INFO|20211015-055149|paul@172.17.0.1:33720|Start reading file|/var/log/dserver/dserver.log|dserver.log
+REMOTE|integrationtest|100|210|dcatcolors.txt|DEBUG|20211015-055149|readFile|readFile(filePath:/var/log/dserver/dserver.log,globID:dserver.log,retry:false,canSkipLines:false,seekEOF:false)
+REMOTE|integrationtest|100|211|dcatcolors.txt|INFO|20211015-055149|/var/log/dserver/dserver.log|End of file reached
+REMOTE|integrationtest|100|212|dcatcolors.txt|DEBUG|20211015-055149|paul@172.17.0.1:33720|shutdown()
+REMOTE|integrationtest|100|213|dcatcolors.txt|TRACE|20211015-055149|paul@172.17.0.1:33720|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|214|dcatcolors.txt|DEBUG|20211015-055149|paul@172.17.0.1:33720|Still lines to be sent
+REMOTE|integrationtest|100|215|dcatcolors.txt|DEBUG|20211015-055149|paul@172.17.0.1:33720|ALL lines sent|0xc0000ba000
+REMOTE|integrationtest|100|216|dcatcolors.txt|INFO|20211015-055149|1|stats.go:53|8|14|7|0.41|781h40m26s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=6
+REMOTE|integrationtest|100|217|dcatcolors.txt|INFO|20211015-055149|paul@172.17.0.1:33720|Good bye Mister!
+REMOTE|integrationtest|100|218|dcatcolors.txt|INFO|20211015-055150|1|stats.go:53|8|11|7|0.41|781h40m27s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=6
+REMOTE|integrationtest|100|219|dcatcolors.txt|INFO|20211015-055154|Handling connection
+REMOTE|integrationtest|100|220|dcatcolors.txt|INFO|20211015-055154|paul@172.17.0.1:33722|Incoming authorization
+REMOTE|integrationtest|100|221|dcatcolors.txt|FATAL|20211015-055154|paul@172.17.0.1:33722|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|222|dcatcolors.txt|INFO|20211015-055154|1|stats.go:53|8|15|7|0.54|781h40m31s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=7
+REMOTE|integrationtest|100|223|dcatcolors.txt|INFO|20211015-055154|paul@172.17.0.1:33722|Invoking channel handler
+REMOTE|integrationtest|100|224|dcatcolors.txt|INFO|20211015-055154|paul@172.17.0.1:33722|Invoking request handler
+REMOTE|integrationtest|100|225|dcatcolors.txt|DEBUG|20211015-055154|paul@172.17.0.1:33722|Creating new server handler
+REMOTE|integrationtest|100|226|dcatcolors.txt|DEBUG|20211015-055154|paul@172.17.0.1:33722|protocol 4 base64 Y2F0OiAvdmFyL2xvZy9kc2VydmVyLyogcmVnZXg6bm9vcCA=
+REMOTE|integrationtest|100|227|dcatcolors.txt|TRACE|20211015-055154|paul@172.17.0.1:33722|Base64 decoded received command|cat: /var/log/dserver/* regex:noop |35|[cat: /var/log/dserver/* regex:noop ]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|228|dcatcolors.txt|DEBUG|20211015-055154|paul@172.17.0.1:33722|Handling user command|35|[cat: /var/log/dserver/* regex:noop ]
+REMOTE|integrationtest|100|229|dcatcolors.txt|DEBUG|20211015-055154|paul@172.17.0.1:33722|/var/log/dserver/dserver.log|readfiles|Checking config permissions
+REMOTE|integrationtest|100|230|dcatcolors.txt|FATAL|20211015-055154|paul@172.17.0.1:33722|/var/log/dserver/dserver.log|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|231|dcatcolors.txt|INFO|20211015-055154|paul@172.17.0.1:33722|Start reading file|/var/log/dserver/dserver.log|dserver.log
+REMOTE|integrationtest|100|232|dcatcolors.txt|DEBUG|20211015-055154|readFile|readFile(filePath:/var/log/dserver/dserver.log,globID:dserver.log,retry:false,canSkipLines:false,seekEOF:false)
+REMOTE|integrationtest|100|233|dcatcolors.txt|INFO|20211015-055154|/var/log/dserver/dserver.log|End of file reached
+REMOTE|integrationtest|100|234|dcatcolors.txt|DEBUG|20211015-055154|paul@172.17.0.1:33722|shutdown()
+REMOTE|integrationtest|100|235|dcatcolors.txt|TRACE|20211015-055154|paul@172.17.0.1:33722|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|236|dcatcolors.txt|DEBUG|20211015-055154|paul@172.17.0.1:33722|Still lines to be sent
+REMOTE|integrationtest|100|237|dcatcolors.txt|DEBUG|20211015-055154|paul@172.17.0.1:33722|ALL lines sent|0xc000300000
+REMOTE|integrationtest|100|238|dcatcolors.txt|INFO|20211015-055154|1|stats.go:53|8|13|7|0.54|781h40m32s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=7
+REMOTE|integrationtest|100|239|dcatcolors.txt|INFO|20211015-055154|paul@172.17.0.1:33722|Good bye Mister!
+REMOTE|integrationtest|100|240|dcatcolors.txt|INFO|20211015-055200|1|stats.go:53|8|11|7|0.58|781h40m37s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=7
+REMOTE|integrationtest|100|241|dcatcolors.txt|INFO|20211015-055201|Handling connection
+REMOTE|integrationtest|100|242|dcatcolors.txt|INFO|20211015-055201|paul@172.17.0.1:33724|Incoming authorization
+REMOTE|integrationtest|100|243|dcatcolors.txt|FATAL|20211015-055201|paul@172.17.0.1:33724|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|244|dcatcolors.txt|INFO|20211015-055201|1|stats.go:53|8|15|7|0.53|781h40m39s|MAPREDUCE:STATS|lifetimeConnections=8|currentConnections=1
+REMOTE|integrationtest|100|245|dcatcolors.txt|INFO|20211015-055201|paul@172.17.0.1:33724|Invoking channel handler
+REMOTE|integrationtest|100|246|dcatcolors.txt|INFO|20211015-055201|paul@172.17.0.1:33724|Invoking request handler
+REMOTE|integrationtest|100|247|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|Creating new server handler
+REMOTE|integrationtest|100|248|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|protocol 4 base64 Y2F0OnNwYXJ0YW49dHJ1ZTpxdWlldD10cnVlIC92YXIvbG9nL2RzZXJ2ZXIvKiByZWdleDpub29wIA==
+REMOTE|integrationtest|100|249|dcatcolors.txt|TRACE|20211015-055201|paul@172.17.0.1:33724|Base64 decoded received command|cat:plain=true:quiet=true /var/log/dserver/* regex:noop |58|[cat:plain=true:quiet=true /var/log/dserver/* regex:noop ]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|250|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|Enabling quiet mode
+REMOTE|integrationtest|100|251|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|Enabling plain mode
+REMOTE|integrationtest|100|252|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|Handling user command|58|[cat:plain=true:quiet=true /var/log/dserver/* regex:noop ]
+REMOTE|integrationtest|100|253|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|/var/log/dserver/dserver.log|readfiles|Checking config permissions
+REMOTE|integrationtest|100|254|dcatcolors.txt|FATAL|20211015-055201|paul@172.17.0.1:33724|/var/log/dserver/dserver.log|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|255|dcatcolors.txt|INFO|20211015-055201|paul@172.17.0.1:33724|Start reading file|/var/log/dserver/dserver.log|dserver.log
+REMOTE|integrationtest|100|256|dcatcolors.txt|DEBUG|20211015-055201|readFile|readFile(filePath:/var/log/dserver/dserver.log,globID:dserver.log,retry:false,canSkipLines:false,seekEOF:false)
+REMOTE|integrationtest|100|257|dcatcolors.txt|INFO|20211015-055201|/var/log/dserver/dserver.log|End of file reached
+REMOTE|integrationtest|100|258|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|shutdown()
+REMOTE|integrationtest|100|259|dcatcolors.txt|TRACE|20211015-055201|paul@172.17.0.1:33724|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|260|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|Still lines to be sent
+REMOTE|integrationtest|100|261|dcatcolors.txt|DEBUG|20211015-055201|paul@172.17.0.1:33724|ALL lines sent|0xc000252000
+REMOTE|integrationtest|100|262|dcatcolors.txt|INFO|20211015-055201|1|stats.go:53|8|13|7|0.53|781h40m39s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=8
+REMOTE|integrationtest|100|263|dcatcolors.txt|INFO|20211015-055201|paul@172.17.0.1:33724|Good bye Mister!
+REMOTE|integrationtest|100|264|dcatcolors.txt|INFO|20211015-055210|1|stats.go:53|8|11|7|0.49|781h40m47s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=8
+REMOTE|integrationtest|100|265|dcatcolors.txt|INFO|20211015-055220|1|stats.go:53|8|11|7|0.49|781h40m57s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=8
+REMOTE|integrationtest|100|266|dcatcolors.txt|INFO|20211015-055223|Handling connection
+REMOTE|integrationtest|100|267|dcatcolors.txt|INFO|20211015-055223|paul@172.17.0.1:33726|Incoming authorization
+REMOTE|integrationtest|100|268|dcatcolors.txt|FATAL|20211015-055223|paul@172.17.0.1:33726|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|269|dcatcolors.txt|INFO|20211015-055223|1|stats.go:53|8|15|7|0.45|781h41m1s|MAPREDUCE:STATS|lifetimeConnections=9|currentConnections=1
+REMOTE|integrationtest|100|270|dcatcolors.txt|INFO|20211015-055223|paul@172.17.0.1:33726|Invoking channel handler
+REMOTE|integrationtest|100|271|dcatcolors.txt|INFO|20211015-055223|paul@172.17.0.1:33726|Invoking request handler
+REMOTE|integrationtest|100|272|dcatcolors.txt|DEBUG|20211015-055223|paul@172.17.0.1:33726|Creating new server handler
+REMOTE|integrationtest|100|273|dcatcolors.txt|FATAL|20211015-053918|SSH relaxed-auth mode enabled
+REMOTE|integrationtest|100|274|dcatcolors.txt|INFO|20211015-053918|Creating server|DTail 4.0.0-RC1 Protocol 4 Have a lot of fun!
+REMOTE|integrationtest|100|275|dcatcolors.txt|INFO|20211015-053918|Generating private server RSA host key
+REMOTE|integrationtest|100|276|dcatcolors.txt|ERROR|20211015-053918|Unable to write private server RSA host key to file|cache/ssh_host_key|open cache/ssh_host_key: no such file or directory
+REMOTE|integrationtest|100|277|dcatcolors.txt|INFO|20211015-053918|Starting server
+REMOTE|integrationtest|100|278|dcatcolors.txt|INFO|20211015-053918|Binding server|0.0.0.0:2222
+REMOTE|integrationtest|100|279|dcatcolors.txt|DEBUG|20211015-053918|Starting listener loop
+REMOTE|integrationtest|100|280|dcatcolors.txt|INFO|20211015-053918|Starting continuous job runner after 10s
+REMOTE|integrationtest|100|281|dcatcolors.txt|INFO|20211015-053918|Starting scheduled job runner after 10s
+REMOTE|integrationtest|100|282|dcatcolors.txt|INFO|20211015-053926|Handling connection
+REMOTE|integrationtest|100|283|dcatcolors.txt|INFO|20211015-053928|paul@172.17.0.1:34250|Incoming authorization
+REMOTE|integrationtest|100|284|dcatcolors.txt|FATAL|20211015-053928|paul@172.17.0.1:34250|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|285|dcatcolors.txt|INFO|20211015-053928|1|stats.go:53|8|16|7|1.34|781h28m6s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=1
+REMOTE|integrationtest|100|286|dcatcolors.txt|INFO|20211015-053928|paul@172.17.0.1:34250|Invoking channel handler
+REMOTE|integrationtest|100|287|dcatcolors.txt|INFO|20211015-053928|paul@172.17.0.1:34250|Invoking request handler
+REMOTE|integrationtest|100|288|dcatcolors.txt|DEBUG|20211015-053928|paul@172.17.0.1:34250|Creating new server handler
+REMOTE|integrationtest|100|289|dcatcolors.txt|DEBUG|20211015-053928|paul@172.17.0.1:34250|protocol 4 base64 dGFpbDogL3Zhci9sb2cvZHNlcnZlci8qIHJlZ2V4Om5vb3Ag
+REMOTE|integrationtest|100|290|dcatcolors.txt|TRACE|20211015-053928|paul@172.17.0.1:34250|Base64 decoded received command|tail: /var/log/dserver/* regex:noop |36|[tail: /var/log/dserver/* regex:noop ]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|291|dcatcolors.txt|DEBUG|20211015-053928|paul@172.17.0.1:34250|Handling user command|36|[tail: /var/log/dserver/* regex:noop ]
+REMOTE|integrationtest|100|292|dcatcolors.txt|DEBUG|20211015-053928|paul@172.17.0.1:34250|/var/log/dserver/dserver.log|readfiles|Checking config permissions
+REMOTE|integrationtest|100|293|dcatcolors.txt|FATAL|20211015-053928|paul@172.17.0.1:34250|/var/log/dserver/dserver.log|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|294|dcatcolors.txt|INFO|20211015-053928|paul@172.17.0.1:34250|Start reading file|/var/log/dserver/dserver.log|dserver.log
+REMOTE|integrationtest|100|295|dcatcolors.txt|DEBUG|20211015-053928|readFile|readFile(filePath:/var/log/dserver/dserver.log,globID:dserver.log,retry:true,canSkipLines:true,seekEOF:true)
+REMOTE|integrationtest|100|296|dcatcolors.txt|INFO|20211015-053928|1|stats.go:53|8|26|7|1.34|781h28m6s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=1
+REMOTE|integrationtest|100|297|dcatcolors.txt|DEBUG|20211015-053931|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|298|dcatcolors.txt|DEBUG|20211015-053934|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|299|dcatcolors.txt|DEBUG|20211015-053937|/var/log/dserver/dserver.log|File truncation check
+REMOTE|integrationtest|100|300|dcatcolors.txt|INFO|20211015-053938|1|stats.go:53|8|26|7|1.21|781h28m16s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=1
+REMOTE|integrationtest|100|301|dcatcolors.txt|INFO|20211015-053939|1|stats.go:53|8|16|7|1.21|781h28m16s|MAPREDUCE:STATS|lifetimeConnections=1|currentConnections=0
+REMOTE|integrationtest|100|302|dcatcolors.txt|INFO|20211015-053939|paul@172.17.0.1:34250|Good bye Mister!
+REMOTE|integrationtest|100|303|dcatcolors.txt|DEBUG|20211015-053939|paul@172.17.0.1:34250|shutdown()
+REMOTE|integrationtest|100|304|dcatcolors.txt|TRACE|20211015-053939|paul@172.17.0.1:34250|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|305|dcatcolors.txt|DEBUG|20211015-053939|paul@172.17.0.1:34250|ALL lines sent|0xc00025a000
+REMOTE|integrationtest|100|306|dcatcolors.txt|INFO|20211015-053942|Handling connection
+REMOTE|integrationtest|100|307|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:34256|Incoming authorization
+REMOTE|integrationtest|100|308|dcatcolors.txt|FATAL|20211015-053942|paul@172.17.0.1:34256|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|309|dcatcolors.txt|INFO|20211015-053942|1|stats.go:53|8|15|7|1.11|781h28m19s|MAPREDUCE:STATS|currentConnections=1|lifetimeConnections=2
+REMOTE|integrationtest|100|310|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:34256|Invoking channel handler
+REMOTE|integrationtest|100|311|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:34256|Invoking request handler
+REMOTE|integrationtest|100|312|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:34256|Creating new server handler
+REMOTE|integrationtest|100|313|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:34256|protocol 4 base64 Y2F0OiAvZXRjL3Bhc3N3ZCByZWdleDpub29wIA==
+REMOTE|integrationtest|100|314|dcatcolors.txt|TRACE|20211015-053942|paul@172.17.0.1:34256|Base64 decoded received command|cat: /etc/passwd regex:noop |28|[cat: /etc/passwd regex:noop ]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|315|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:34256|Handling user command|28|[cat: /etc/passwd regex:noop ]
+REMOTE|integrationtest|100|316|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:34256|/etc/passwd|readfiles|Checking config permissions
+REMOTE|integrationtest|100|317|dcatcolors.txt|FATAL|20211015-053942|paul@172.17.0.1:34256|/etc/passwd|readfiles|Server releaxed auth enabled
+REMOTE|integrationtest|100|318|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:34256|Start reading file|/etc/passwd|passwd
+REMOTE|integrationtest|100|319|dcatcolors.txt|DEBUG|20211015-053942|readFile|readFile(filePath:/etc/passwd,globID:passwd,retry:false,canSkipLines:false,seekEOF:false)
+REMOTE|integrationtest|100|320|dcatcolors.txt|INFO|20211015-053942|/etc/passwd|End of file reached
+REMOTE|integrationtest|100|321|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:34256|shutdown()
+REMOTE|integrationtest|100|322|dcatcolors.txt|TRACE|20211015-053942|paul@172.17.0.1:34256|flush()|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:278
+REMOTE|integrationtest|100|323|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:34256|Still lines to be sent
+REMOTE|integrationtest|100|324|dcatcolors.txt|DEBUG|20211015-053942|paul@172.17.0.1:34256|ALL lines sent|0xc00025a0e0
+REMOTE|integrationtest|100|325|dcatcolors.txt|ERROR|20211015-053942|paul@172.17.0.1:34256|read tcp 172.17.0.7:2222->172.17.0.1:34256: use of closed network connection
+REMOTE|integrationtest|100|326|dcatcolors.txt|INFO|20211015-053942|1|stats.go:53|8|15|7|1.11|781h28m19s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=2
+REMOTE|integrationtest|100|327|dcatcolors.txt|INFO|20211015-053942|paul@172.17.0.1:34256|Good bye Mister!
+REMOTE|integrationtest|100|328|dcatcolors.txt|INFO|20211015-053948|1|stats.go:53|8|11|7|1.10|781h28m26s|MAPREDUCE:STATS|currentConnections=0|lifetimeConnections=2
+REMOTE|integrationtest|100|329|dcatcolors.txt|INFO|20211015-053949|Handling connection
+REMOTE|integrationtest|100|330|dcatcolors.txt|INFO|20211015-053949|paul@172.17.0.1:34258|Incoming authorization
+REMOTE|integrationtest|100|331|dcatcolors.txt|FATAL|20211015-053949|paul@172.17.0.1:34258|Granting permissions via relaxed-auth
+REMOTE|integrationtest|100|332|dcatcolors.txt|INFO|20211015-053949|1|stats.go:53|8|15|7|1.10|781h28m26s|MAPREDUCE:STATS|lifetimeConnections=3|currentConnections=1
+REMOTE|integrationtest|100|333|dcatcolors.txt|INFO|20211015-053949|paul@172.17.0.1:34258|Invoking channel handler
+REMOTE|integrationtest|100|334|dcatcolors.txt|INFO|20211015-053949|paul@172.17.0.1:34258|Invoking request handler
+REMOTE|integrationtest|100|335|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:34258|Creating new server handler
+REMOTE|integrationtest|100|336|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:34258|protocol 4 base64 bWFwIGZyb20gc3RhdHMgc2VsZWN0IGF2ZygkZ29yb3V0aW5lcyksbWF4KCRnb3JvdXRpbmVzKSxtaW4oJGdvcm91dGluZXMpLGxhc3QoJGdvcm91dGluZXMpLGNvdW50KCRob3N0bmFtZSksJGhvc3RuYW1lIGdyb3VwIGJ5ICRob3N0bmFtZSBvcmRlciBieSBhdmcoJGdvcm91dGluZXMp
+REMOTE|integrationtest|100|337|dcatcolors.txt|TRACE|20211015-053949|paul@172.17.0.1:34258|Base64 decoded received command|map from stats select avg($goroutines),max($goroutines),min($goroutines),last($goroutines),count($hostname),$hostname group by $hostname order by avg($goroutines)|162|[map from stats select avg($goroutines),max($goroutines),min($goroutines),last($goroutines),count($hostname),$hostname group by $hostname order by avg($goroutines)]|at /home/paul/git/dtail/internal/server/handlers/basehandler.go:225
+REMOTE|integrationtest|100|338|dcatcolors.txt|DEBUG|20211015-053949|paul@172.17.0.1:34258|Handling user command|162|[map from stats select avg($goroutines),max($goroutines),min($goroutines),last($goroutines),count($hostname),$hostname group by $hostname order by avg($goroutines)]
+REMOTE|integrationtest|100|3