Daily Usenet report

Feb 21 04:15:01 -- Feb 22 04:15:02

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Feb 21 05:50:17 newsfeed overchan[18744]: input line too long, skipping
Feb 21 08:20:16 newsfeed overchan[18744]: input line too long, skipping
Feb 21 08:21:14 newsfeed overchan[18744]: input line too long, skipping
Feb 21 08:21:27 newsfeed overchan[18744]: input line too long, skipping
Feb 21 10:46:41 newsfeed overchan[18744]: input line too long, skipping
Feb 21 10:47:34 newsfeed nnrpd[2080]: SERVER perl filter not defined
Feb 21 14:58:26 newsfeed overchan[18744]: input line too long, skipping
Feb 21 16:37:36 newsfeed overchan[18744]: input line too long, skipping
Feb 21 19:22:05 newsfeed overchan[18744]: input line too long, skipping
Feb 21 19:22:16 newsfeed overchan[18744]: input line too long, skipping
Feb 21 19:22:28 newsfeed overchan[18744]: input line too long, skipping
Feb 21 19:55:41 newsfeed overchan[18744]: input line too long, skipping
Feb 21 20:20:13 newsfeed overchan[18744]: input line too long, skipping
Feb 21 22:40:40 newsfeed overchan[18744]: input line too long, skipping
Feb 22 02:41:48 newsfeed overchan[18744]: input line too long, skipping
Feb 22 03:49:16 newsfeed overchan[18744]: input line too long, skipping
Feb 22 04:06:47 newsfeed nnrpd[8499]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2275192 97.1%262.4 MB 96.7%
innfeed 43346 1.8%5.1 MB 1.9%
innd 20276 0.9%3.2 MB 1.2%
nnrpd 5004 0.2%526.4 KB 0.2%
overchan 17 0.0%2.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62343836 100.0%271.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2250907 96.8%
Negative hits 61175 2.6%
Positive hits 12541 0.5%
Cache misses 105 0.0%
TOTAL: 4 2324728 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.787 0.0%327 0.000 20.755 491.000
article cleanup00:00:25.992 0.0%2274967 0.008 0.011 0.015
article logging00:01:35.624 0.1%2275593 0.029 0.042 0.078
article parse00:32:06.596 2.2%59441260 0.018 0.032 0.042
article write00:12:24.171 0.9%2259998 0.187 0.329 0.575
artlog/artcncl00:00:00.012 0.0%311 0.000 0.039 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:17.741 0.1%69325534 0.001 0.001 0.002
hisgrep/artcncl00:00:00.849 0.0%320 0.000 2.653 28.000
hishave/artcncl00:00:00.104 0.0%327 0.000 0.318 7.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:40:23.592 2.8%2338751 0.096 1.036 5.782
history sync00:00:00.017 0.0%290 0.000 0.059 0.500
history write01:51:01.649 7.7%2263923 0.864 2.943 14.329
hiswrite/artcncl00:00:00.018 0.0%7 1.000 2.571 3.333
idle16:21:02.337 68.1%47298350 0.376 1.244 4.799
nntp read00:38:54.413 2.7%58291008 0.027 0.040 0.057
overview write00:00:11.624 0.0%2259998 0.003 0.005 0.008
perl filter03:11:12.395 13.3%2263923 2.463 5.067 6.389
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:37.587 0.3%4539534 0.032 0.061 0.082
TOTAL: 24:00:03.23823:35:21.508 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.130 0.0%54177 0.000 0.002 0.011
article prepare00:00:00.003 0.0%13350 0.000 0.000 0.018
article read00:00:56.991 0.1%3312 1.571 17.207 262.417
backlog stats00:00:00.154 0.0%174370 0.000 0.001 0.006
callbacks00:00:00.000 0.0%4 0.000 0.000 0.000
data read00:00:01.687 0.0%91095 0.006 0.019 0.033
data write00:00:04.164 0.0%72128 0.022 0.058 0.093
idle23:52:10.985 99.9%174370 339.257 492.808 807.573
status file00:00:15.998 0.0%15877 0.600 1.008 7.656
TOTAL: 23:53:42.68723:53:30.112100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:11:57.464 74.0%3102 0.000 231.291213647.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.316 0.0%6787 0.000 0.047 2.368
readart00:00:00.003 0.0%26 0.000 0.115 0.500
TOTAL: 00:16:09.62700:11:57.783 74.0%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1132 22587832247333 301 11149 99%376:52:11
2news.nask.pl 3 16542 12003 772 3767 72%24:12:04
3news.icm.edu.pl 41 311 22 281 8 7%18:52:04
4localhost 3 2 2 0 0 100%00:00:00
TOTAL: 4 1179 22756382259360 1354 14924 99%419:56:19
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl464.0 GB46.6 MB68.4 MB464.1 GB 99%215.5 KB
2news.nask.pl47.6 MB575.6 KB21.5 MB69.7 MB 68%4.5 KB
3news.icm.edu.pl501.0 KB22.4 KB127.5 KB650.9 KB 76%21.7 KB
4localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
TOTAL: 4464.0 GB47.2 MB90.0 MB464.1 GB 99%214.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 21 04:15:01 - 04:59:59 93937 4.2% 34.8022.3 GB 4.8%8650.22
Feb 21 05:00:00 - 05:59:59 131589 5.8% 36.5531.2 GB 6.7%9099.08
Feb 21 06:00:00 - 06:59:59 130290 5.8% 36.1931.8 GB 6.9%9266.68
Feb 21 07:00:00 - 07:59:59 106196 4.7% 29.5024.2 GB 5.2%7056.83
Feb 21 08:00:00 - 08:59:59 135374 6.0% 37.6032.3 GB 7.0%9409.34
Feb 21 09:00:00 - 09:59:59 127210 5.6% 35.3426.3 GB 5.7%7653.23
Feb 21 10:00:00 - 10:59:59 82520 3.7% 22.9213.4 GB 2.9%3898.40
Feb 21 11:00:00 - 11:59:59 103679 4.6% 28.8021.8 GB 4.7%6352.29
Feb 21 12:00:00 - 12:59:59 108000 4.8% 30.0024.3 GB 5.2%7086.90
Feb 21 13:00:00 - 13:59:59 74214 3.3% 20.6115.3 GB 3.3%4443.64
Feb 21 14:00:00 - 14:59:59 78960 3.5% 21.9316.1 GB 3.5%4676.70
Feb 21 15:00:00 - 15:59:59 54688 2.4% 15.197.6 GB 1.6%2209.79
Feb 21 16:00:00 - 16:59:59 52185 2.3% 14.507.6 GB 1.6%2219.15
Feb 21 17:00:00 - 17:59:59 67982 3.0% 18.8813.1 GB 2.8%3805.49
Feb 21 18:00:00 - 18:59:59 103507 4.6% 28.7525.6 GB 5.5%7451.08
Feb 21 19:00:00 - 19:59:59 98542 4.4% 27.3721.2 GB 4.6%6164.34
Feb 21 20:00:00 - 20:59:59 63945 2.8% 17.7611.7 GB 2.5%3414.35
Feb 21 21:00:00 - 21:59:59 104232 4.6% 28.9520.1 GB 4.3%5863.57
Feb 21 22:00:00 - 22:59:59 108638 4.8% 30.1821.9 GB 4.7%6391.53
Feb 21 23:00:00 - 23:59:59 126776 5.6% 35.2223.3 GB 5.0%6784.87
Feb 22 00:00:00 - 00:59:59 67871 3.0% 18.859.2 GB 2.0%2689.86
Feb 22 01:00:00 - 01:59:59 48479 2.1% 13.475.2 GB 1.1%1507.41
Feb 22 02:00:00 - 02:59:59 84186 3.7% 23.3916.4 GB 3.5%4774.19
Feb 22 03:00:00 - 03:59:59 85036 3.8% 23.6217.6 GB 3.8%5118.92
Feb 22 04:00:00 - 04:15:02 21245 0.9% 23.554.4 GB 0.9%5065.89
TOTAL: 24:00:01 2259281 100.0% 26.15463.8 GB 100.0%5628.78
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 11455 162 0 10826 2 0 0 0 465
2news.nask.pl 4134 46 0 213 6 0 0 0 3869
3news.icm.edu.pl 10 0 0 2 0 0 0 0 8
TOTAL: 3 15599 208 0 11041 8 0 0 0 4342

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 118
it.comp.os.win.windows10 22
comp.sys.raspberry-pi 20
it.tlc.cellulari.android 17
comp.mobile.android 17
de.comp.lang.vbclassic 9
de.comm.software.mailreader 4
it.tlc.cellulari.iphone 1
TOTAL: 8 208

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
pl.sci.matematyka 6
pl.praca.oferowana 1
bit.listserv.catholic 1
TOTAL: 3 8

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3247
Binary in non-binary group 348
Scoring filter (9) 33
Scoring filter (8) 27
EMP (phl) 24
HTML post 19
Excessively crossposted test article 11
Scoring filter (10) 4
Scoring filter (18) 1
Scoring filter (12) 1
TOTAL: 10 3715

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nask.pl 319
newsfeed.pionier.net.pl 306
news.icm.edu.pl 2
TOTAL: 3 627
TOTAL: 1 627

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 40855 1157 13087 253 18 39923 2%24:00:10
2poznan 20871 707 11211 29 1 0 3%23:59:57
3icm 25884 44 19239 44 0 1 0%23:59:33
4nask 1551 2 1101 0 0 1 0%21:15:50
5okapi 0 0 0 0 0 1251 0%24:05:37
TOTAL: 5 89161 1910 44638 326 19 41176 2%117:21:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama5.0 MB866.8 KB5.9 MB0.1 KB/s4.3 KB24:00:10
2icm3.6 MB8.5 MB12.1 MB0.1 KB/s140.3 KB23:59:33
3poznan2.6 MB123.9 KB2.8 MB0.0 KB/s3.8 KB23:59:57
4nask2.5 KB0.0 KB2.5 KB0.0 KB/s1.2 KB21:15:50
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:37
TOTAL: 511.3 MB9.4 MB20.7 MB0.1 KB/s9.5 KB117:21:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 290 2624.7 KB 12 0 000:00:16
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 292 2624.7 KB 12 2 000:16:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 676 2624.7 KB 12 2 000:00:21
2unresolved 44 00.0 KB 0 0 000:15:47
TOTAL: 2 720 2624.7 KB 12 2 000:16:08

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.51.203.199 0.008 0.024 0.00000:11:45
164.52.7.165 0.268 1.048 0.00000:04:01
web.man.lodz.pl 1.824 7.772 0.00000:00:16
mon.man.lodz.pl 1.436 6.596 0.00000:00:03
david.man.lodz.pl 0.360 2.044 0.00000:00:00
isvcs01.man.lodz.pl 0.016 0.056 0.00000:00:00
TOTAL: 6 3.912 17.540 0.00000:16:08

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
164.52.7.165 42
212.51.203.199 2
TOTAL: 4 428

NNRP unrecognized commands (by host):

SystemConn
164.52.7.165 20
TOTAL: 1 20

NNRP unrecognized commands (by command):

CommandCount
#003 7
USER test +iw test :Test Wuz Here 1
À/À+À'À#À#023À 1
#026#003#001#001"#001 1
W 1
#005d#005É 1
fox a 1 -1 fox hello 1
OPTIONS * RTSP/1.0 1
GET / HTTP/1.1 1
stats 1
NICK vldbrezyt 1
#003printer 1
@RSYNCD: 29 1
INFO ALL 1
TOTAL: 14 20

NNRP client timeouts [Top 20]:

SystemConnPeer
164.52.7.165 1 2
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 26100.0%
TOTAL: 1 26100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1pl.comp.os.ms-windows.winnt 22
2pl.comp.pecet 4
TOTAL: 2 26