Daily Usenet report

Feb 3 04:15:03 -- Feb 4 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Feb 3 07:06:57 newsfeed overchan[20155]: input line too long, skipping
Feb 3 13:20:02 newsfeed controlchan[20152]: Unknown "tags" control by robomod@news.nic.it
Feb 3 15:30:02 newsfeed pgpverify[14073]: pgpverify: verification failed
Feb 3 18:33:44 newsfeed overchan[20155]: input line too long, skipping
Feb 3 18:46:23 newsfeed nnrpd[21465]: SERVER perl filter not defined
Feb 3 18:49:42 newsfeed nnrpd[21513]: SERVER perl filter not defined
Feb 3 19:11:11 newsfeed overchan[20155]: input line too long, skipping
Feb 3 19:28:48 newsfeed overchan[20155]: input line too long, skipping
Feb 3 19:49:55 newsfeed overchan[20155]: input line too long, skipping
Feb 3 20:32:46 newsfeed nnrpd[25490]: SERVER perl filter not defined
Feb 3 20:55:43 newsfeed overchan[20155]: input line too long, skipping
Feb 3 23:21:48 newsfeed nnrpd[31889]: SERVER perl filter not defined
Feb 3 23:24:28 newsfeed nnrpd[31931]: SERVER perl filter not defined
Feb 4 02:26:49 newsfeed overchan[20155]: input line too long, skipping
Feb 4 04:12:35 newsfeed overchan[20155]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2367342 97.1%274.8 MB 96.8%
innfeed 45744 1.9%5.4 MB 1.9%
innd 18949 0.8%3.1 MB 1.1%
nnrpd 4777 0.2%503.1 KB 0.2%
overchan 9 0.0%1.8 KB 0.0%
controlchan 5 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 72436827 100.0%283.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2352900 95.1%
Negative hits 109943 4.4%
Positive hits 9973 0.4%
Cache misses 117 0.0%
TOTAL: 4 2472933 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.181 0.0%199 0.000 21.010 412.000
article cleanup00:00:29.412 0.0%2365633 0.008 0.012 0.017
article logging00:01:48.130 0.1%2366327 0.035 0.046 0.122
article parse00:44:15.907 3.1%65452514 0.025 0.041 0.055
article write00:16:58.837 1.2%2359473 0.209 0.432 0.981
artlog/artcncl00:00:00.005 0.0%181 0.000 0.028 0.214
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:48.083 0.1%77976620 0.001 0.001 0.003
hisgrep/artcncl00:00:01.115 0.0%195 0.000 5.718 36.000
hishave/artcncl00:00:00.648 0.0%199 0.000 3.256 94.750
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:08:23.020 8.9%2485185 0.492 3.100 10.162
history sync00:00:00.014 0.0%295 0.000 0.047 0.500
history write05:02:21.978 21.0%2363660 2.250 7.675 16.203
hiswrite/artcncl00:00:00.038 0.0%4 6.000 9.500 11.500
idle10:03:36.163 41.9%42847980 0.125 0.845 3.388
nntp read00:46:08.127 3.2%63624951 0.033 0.044 0.053
overview write00:00:13.501 0.0%2359473 0.004 0.006 0.010
perl filter04:24:16.159 18.4%2363660 4.678 6.708 7.971
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:57.801 0.3%4737553 0.046 0.063 0.087
TOTAL: 24:00:07.41423:35:23.119 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.146 0.0%56504 0.000 0.003 0.016
article prepare00:00:00.003 0.0%10268 0.000 0.000 0.015
article read00:01:28.331 0.1%2584 0.000 34.184 257.692
backlog stats00:00:00.115 0.0%150425 0.000 0.001 0.006
callbacks00:00:00.001 0.0%52 0.000 0.019 1.000
data read00:00:01.413 0.0%81310 0.004 0.017 0.035
data write00:00:03.705 0.0%63001 0.019 0.059 0.110
idle23:51:49.516 99.8%150425 376.293 571.112 1099.786
status file00:00:32.803 0.0%15865 0.767 2.068 33.258
TOTAL: 23:54:06.66123:53:56.033100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:35.307 76.0%3051 0.000 11.572 9740.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.250 0.5%6724 0.000 0.037 0.500
readart00:00:00.000 0.0%36 0.000 0.000 0.000
TOTAL: 00:00:46.46500:00:35.557 76.5%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 677 23597062350222 6577 2907 99%472:41:41
2news.nask.pl 2 13205 8984 1186 3035 68%23:57:49
3news.icm.edu.pl 48 257 19 216 22 7%16:09:35
4localhost 6 5 5 0 0 100%00:00:00
TOTAL: 4 733 23731732359230 7979 5964 99%512:49:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl620.2 GB15.5 MB188.7 MB620.4 GB 99%276.5 KB
2news.nask.pl45.0 MB409.3 KB16.7 MB62.0 MB 72%5.3 KB
3news.icm.edu.pl722.7 KB0.0 KB1.5 MB2.2 MB 32%54.4 KB
4localhost7.2 KB0.0 KB0.0 KB7.2 KB100%1.4 KB
TOTAL: 4620.2 GB15.9 MB206.8 MB620.5 GB 99%275.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 3 04:15:03 - 04:59:59 63318 2.7% 23.4817.6 GB 2.8%6857.96
Feb 3 05:00:00 - 05:59:59 83203 3.5% 23.1125.5 GB 4.1%7440.04
Feb 3 06:00:00 - 06:59:59 103867 4.4% 28.8531.0 GB 5.0%9041.38
Feb 3 07:00:00 - 07:59:59 89296 3.8% 24.8026.9 GB 4.3%7845.87
Feb 3 08:00:00 - 08:59:59 123557 5.2% 34.3236.5 GB 5.9%10620.60
Feb 3 09:00:00 - 09:59:59 127465 5.4% 35.4136.7 GB 5.9%10696.49
Feb 3 10:00:00 - 10:59:59 108329 4.6% 30.0932.4 GB 5.2%9438.13
Feb 3 11:00:00 - 11:59:59 130778 5.5% 36.3331.7 GB 5.1%9226.23
Feb 3 12:00:00 - 12:59:59 63312 2.7% 17.5917.4 GB 2.8%5053.72
Feb 3 13:00:00 - 13:59:59 29380 1.2% 8.167.5 GB 1.2%2175.41
Feb 3 14:00:00 - 14:59:59 75292 3.2% 20.9122.8 GB 3.7%6644.93
Feb 3 15:00:00 - 15:59:59 100900 4.3% 28.0331.1 GB 5.0%9060.98
Feb 3 16:00:00 - 16:59:59 94929 4.0% 26.3729.5 GB 4.8%8601.55
Feb 3 17:00:00 - 17:59:59 74679 3.2% 20.7422.7 GB 3.7%6603.19
Feb 3 18:00:00 - 18:59:59 78952 3.3% 21.9322.2 GB 3.6%6456.78
Feb 3 19:00:00 - 19:59:59 65266 2.8% 18.1319.0 GB 3.1%5539.50
Feb 3 20:00:00 - 20:59:59 62462 2.6% 17.3518.2 GB 2.9%5309.73
Feb 3 21:00:00 - 21:59:59 163502 6.9% 45.4234.7 GB 5.6%10103.78
Feb 3 22:00:00 - 22:59:59 150355 6.4% 41.7730.7 GB 5.0%8949.60
Feb 3 23:00:00 - 23:59:59 113978 4.8% 31.6628.1 GB 4.5%8173.49
Feb 4 00:00:00 - 00:59:59 78219 3.3% 21.7319.5 GB 3.1%5668.27
Feb 4 01:00:00 - 01:59:59 75211 3.2% 20.8918.8 GB 3.0%5480.70
Feb 4 02:00:00 - 02:59:59 139672 5.9% 38.8028.5 GB 4.6%8302.20
Feb 4 03:00:00 - 03:59:59 137467 5.8% 38.1925.9 GB 4.2%7530.19
Feb 4 04:00:00 - 04:15:02 27138 1.1% 30.095.2 GB 0.8%6057.42
TOTAL: 23:59:59 2360527 100.0% 27.32620.1 GB 100.0%7525.85
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3412 135 0 1822 6 0 0 0 1449
2news.nask.pl 3200 11 0 165 8 0 0 0 3016
3news.icm.edu.pl 22 0 0 0 0 0 0 0 22
TOTAL: 3 6634 146 0 1987 14 0 0 0 4487

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 93
it.comp.os.win.windows10 27
comp.mobile.android 6
it.tlc.cellulari.android 3
de.rec.sf.startrek 3
comp.sys.raspberry-pi 2
de.comp.office-pakete.ms-office.misc 2
nl.wetenschap.regulier 1
it.comp.os.linux.ubuntu 1
nl.gezondheid.alternatief-genezen 1
it.discussioni.energia 1
comp.mobile.ipad 1
nl.comp.os.linux.techniek 1
hr.sci.med 1
nl.comp.sys.android 1
nl.comp.3d-printen 1
nl.actueel 1
TOTAL: 17 146

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

GroupsCount
pl.sci.matematyka 10
pl.praca.oferowana 3
bit.listserv.catholic 1
TOTAL: 3 14

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2693
Binary in non-binary group 1002
Scoring filter (8) 28
Poison newsgroup 23
Scoring filter (9) 20
Scoring filter (10) 6
Scoring filter (18) 5
HTML post 4
Too many newsgroups 3
Scoring filter (11) 3
Scoring filter (19) 1
EMP (fsl) 1
Scoring filter (16) 1
TOTAL: 13 3790

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 515
news.nask.pl 182
TOTAL: 2 697
TOTAL: 1 697

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 42471 979 14752 212 102 40660 2%23:59:57
2poznan 13578 324 8635 20 0 0 2%23:59:57
3icm 21785 28 17981 18 0 0 0%23:59:52
4nask 3518 5 3024 0 0 0 0%23:59:37
5okapi 0 0 0 0 0 1341 0%23:57:50
TOTAL: 5 81352 1336 44392 250 102 42001 1%119:57:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama6.8 MB1.1 MB7.9 MB0.1 KB/s6.8 KB23:59:57
2poznan1.3 MB265.3 KB1.5 MB0.0 KB/s4.5 KB23:59:57
3icm855.4 KB2.0 MB2.8 MB0.0 KB/s63.0 KB23:59:52
4nask9.4 KB0.0 KB9.4 KB0.0 KB/s1.9 KB23:59:37
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 58.9 MB3.4 MB12.3 MB0.0 KB/s7.9 KB119:57:13
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3636.7 KB 15 0 000:00:30
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 293 3636.7 KB 15 5 000:00:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 677 3636.7 KB 15 5 000:00:35
2unresolved 1 00.0 KB 0 0 000:00:09
TOTAL: 2 678 3636.7 KB 15 5 000:00:45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.456 7.032 0.00000:00:30
192.241.197.61 0.012 0.020 0.00000:00:09
mon.man.lodz.pl 1.432 6.640 0.00000:00:03
david.man.lodz.pl 0.468 2.436 0.00000:00:01
isvcs01.man.lodz.pl 0.048 0.112 0.00000:00:00
TOTAL: 5 3.416 16.240 0.00000:00:45

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
192.241.197.61 1
TOTAL: 3 385

Newsgroup request counts (by category):

CategoryCountPct
1pl 36100.0%
TOTAL: 1 36100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 28
2pl.comp.pecet 8
TOTAL: 2 36