Attachment 619347 Details for Bug 911347

Records of time taken to flush the runtime journal to disk on 120GB unit

flushing_journal_time.txt (text/plain), 8.58 KB, created by Bruno Pesavento on 2015-01-13 00:14:46 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Bruno Pesavento

Created: 2015-01-13 00:14:46 UTC

Size: 8.58 KB

patch

obsolete

>System disk is a ST9120822AS unit, 120GB, 2.5", 5400rpm, 33MB/s, 12ms access time.
>File journald.conf used to record lines 31 to 67 in the following
>
>[Journal]
>#Storage=auto
>#Compress=yes
>#Seal=yes
>SplitMode=none          <<<<<<<<<
>#SyncIntervalSec=5m
>#RateLimitInterval=30s
>#RateLimitBurst=1000
>SystemMaxUse=400M       <<<<<<<<<
>#SystemKeepFree=
>#SystemMaxFileSize=
>#RuntimeMaxUse=
>#RuntimeKeepFree=
>#RuntimeMaxFileSize=
>#MaxRetentionSec=
>#MaxFileSec=1month
>#ForwardToSyslog=yes
>#ForwardToKMsg=no
>#ForwardToConsole=no
>#TTYPath=/dev/tty10
>#MaxLevelStore=debug
>#MaxLevelSyslog=debug
>#MaxLevelKMsg=notice
>#MaxLevelConsole=info
>
>........size of file "system.journal" at time of flushing to disk.
>
>........8.4MB
>gen 13 00:02:17 linux-a2yg systemd-journal[362]: Permanent journal is using 228.0M (max allowed 400.0M, trying to leave 1.5G free of 1.5G av
>gen 13 00:02:20 linux-a2yg systemd-journal[362]: Time spent on flushing to /var is 2.269770s for 1160 entries.
>
>gen 12 21:24:09 linux-a2yg systemd-journal[363]: Permanent journal is using 228.0M (max allowed 400.0M, trying to leave 1.5G free of 1.5G av
>gen 12 21:24:10 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 1.119657s for 1171 entries.
>
>........41.9MB
>gen 12 21:15:58 linux-a2yg systemd-journal[364]: Permanent journal is using 220.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 12 21:16:33 linux-a2yg systemd-journal[364]: Time spent on flushing to /var is 34.749654s for 1168 entries.
>
>........33.6MB
>gen 12 21:00:52 linux-a2yg systemd-journal[363]: Permanent journal is using 212.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 12 21:01:21 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 29.422710s for 1168 entries.
>
>gen 12 20:41:59 linux-a2yg systemd-journal[363]: Permanent journal is using 212.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 12 20:42:23 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 24.183476s for 1171 entries.
>
>........25.2MB
>gen 12 19:48:11 linux-a2yg systemd-journal[364]: Permanent journal is using 204.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 12 19:48:31 linux-a2yg systemd-journal[364]: Time spent on flushing to /var is 20.478964s for 1171 entries.
>
>gen 12 19:21:40 linux-a2yg systemd-journal[364]: Permanent journal is using 204.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 12 19:22:00 linux-a2yg systemd-journal[364]: Time spent on flushing to /var is 19.948710s for 1170 entries.
>
>gen 12 18:47:45 linux-a2yg systemd-journal[361]: Permanent journal is using 204.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 12 18:48:02 linux-a2yg systemd-journal[361]: Time spent on flushing to /var is 17.040065s for 1140 entries.
>
>gen 10 21:24:21 linux-a2yg systemd-journal[362]: Permanent journal is using 204.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 10 21:24:35 linux-a2yg systemd-journal[362]: Time spent on flushing to /var is 13.838971s for 1135 entries.
>
>........16.8MB
>gen 10 20:53:12 linux-a2yg systemd-journal[362]: Permanent journal is using 196.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 10 20:53:20 linux-a2yg systemd-journal[362]: Time spent on flushing to /var is 8.815520s for 1134 entries.
>
>gen 10 17:03:33 linux-a2yg systemd-journal[363]: Permanent journal is using 196.0M (max allowed 400.0M, trying to leave 1.5G free of 1.6G av
>gen 10 17:03:40 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 6.541506s for 1137 entries.
>
>gen 10 15:50:28 linux-a2yg systemd-journal[363]: Permanent journal is using 188.0M (max allowed 400.0M, trying to leave 1.5G free of 1.0G av
>gen 10 15:50:34 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 5.413873s for 1128 entries.
>
>........8.4MB
>gen 10 01:11:28 linux-a2yg systemd-journal[364]: Permanent journal is using 188.0M (max allowed 400.0M, trying to leave 1.5G free of 1.1G av
>gen 10 01:11:32 linux-a2yg systemd-journal[364]: Time spent on flushing to /var is 4.101983s for 1140 entries.
>
>gen 10 00:30:04 linux-a2yg systemd-journal[361]: Permanent journal is using 188.0M (max allowed 400.0M, trying to leave 1.5G free of 1.1G av
>gen 10 00:30:05 linux-a2yg systemd-journal[361]: Time spent on flushing to /var is 938.866ms for 1126 entries.
>
>gen 10 00:05:54 linux-a2yg systemd-journal[364]: Permanent journal is using 188.0M (max allowed 400.0M, trying to leave 1.5G free of 1.1G av
>gen 10 00:05:54 linux-a2yg systemd-journal[364]: Time spent on flushing to /var is 261.352ms for 1148 entries.
>
>........0MB (just after file recycling)
>8.4MB gen 09 23:52:18 linux-a2yg systemd-journal[361]: Permanent journal is using 188.0M (max allowed 400.0M, trying to leave 1.5G free of 1.0G av
>gen 09 23:52:18 linux-a2yg systemd-journal[361]: Time spent on flushing to /var is 52.862ms for 1141 entries.
>
>........25.2MB 
>gen 09 23:05:48 linux-a2yg systemd-journal[364]: Permanent journal is using 176.0M (max allowed 400.0M, trying to leave 1.5G free of 1.1G av
>gen 09 23:06:08 linux-a2yg systemd-journal[364]: Time spent on flushing to /var is 20.139724s for 1133 entries.
>
>gen 09 22:44:02 linux-a2yg systemd-journal[362]: Permanent journal is using 176.0M (max allowed 400.0M, trying to leave 1.5G free of 1.1G av
>gen 09 22:44:22 linux-a2yg systemd-journal[362]: Time spent on flushing to /var is 20.187066s for 1138 entries.
>
>........16.8MB
>gen 09 22:40:13 linux-a2yg systemd-journal[361]: Permanent journal is using 172.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>gen 09 22:40:30 linux-a2yg systemd-journal[361]: Time spent on flushing to /var is 16.254196s for 1136 entries.
>
>gen 07 23:58:23 linux-a2yg systemd-journal[362]: Permanent journal is using 172.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>gen 07 23:58:39 linux-a2yg systemd-journal[362]: Time spent on flushing to /var is 16.356379s for 1130 entries.
> 
>gen 03 17:09:48 linux-a2yg systemd-journal[363]: Permanent journal is using 172.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>gen 03 17:10:03 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 15.619106s for 1143 entries.
>
>dic 31 21:33:35 linux-a2yg systemd-journal[362]: Permanent journal is using 172.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 31 21:33:44 linux-a2yg systemd-journal[362]: Time spent on flushing to /var is 8.949518s for 1143 entries.
>
>dic 31 20:43:43 linux-a2yg systemd-journal[363]: Permanent journal is using 172.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 31 20:43:54 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 10.657260s for 1111 entries.
>
>dic 31 17:39:26 linux-a2yg systemd-journal[363]: Permanent journal is using 172.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 31 17:39:31 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 5.058604s for 1134 entries.
>
>........8.4MB
>dic 31 17:21:38 linux-a2yg systemd-journal[363]: Permanent journal is using 164.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 31 17:21:43 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 4.962933s for 1136 entries.
>
>dic 31 17:02:59 linux-a2yg systemd-journal[363]: Permanent journal is using 164.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 31 17:03:02 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 2.911777s for 1161 entries.
>
>dic 31 16:50:21 linux-a2yg systemd-journal[362]: Permanent journal is using 164.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 31 16:50:22 linux-a2yg systemd-journal[362]: Time spent on flushing to /var is 1.062088s for 1168 entries.
>
>dic 31 16:15:11 linux-a2yg systemd-journal[362]: Permanent journal is using 164.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 31 16:15:11 linux-a2yg systemd-journal[362]: Time spent on flushing to /var is 329.792ms for 1166 entries.
>
>........0MB (just after file recycling)
>8.4MB dic 31 14:25:51 linux-a2yg systemd-journal[363]: Permanent journal is using 164.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 31 14:25:51 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 51.059ms for 1120 entries.
>
>........21MB
>dic 30 17:52:50 linux-a2yg systemd-journal[363]: Permanent journal is using 172.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 30 17:53:09 linux-a2yg systemd-journal[363]: Time spent on flushing to /var is 19.003634s for 1116 entries.
>
>dic 30 14:55:42 linux-a2yg systemd-journal[361]: Permanent journal is using 168.0M (max allowed 160.0M, trying to leave 1.5G free of 1.1G av
>dic 30 14:55:59 linux-a2yg systemd-journal[361]: Time spent on flushing to /var is 17.669757s for 1142 entries.
>

Actions: View

Attachments on bug 911347: 619347 | 619455 | 619596 | 620725 | 621355