Daily Usenet report

May 21 04:15:02 -- May 22 04:15:04

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

May 21 09:11:05 newsfeed overchan[21070]: input line too long, skipping
May 21 10:59:42 newsfeed nnrpd[4265]: SERVER perl filter not defined
May 21 11:09:00 newsfeed nnrpd[4630]: SERVER perl filter not defined
May 21 13:17:30 newsfeed nnrpd[9361]: SERVER perl filter not defined
May 21 13:18:36 newsfeed nnrpd[9376]: SERVER perl filter not defined
May 21 16:10:29 newsfeed nnrpd[15884]: SERVER perl filter not defined
May 21 16:14:38 newsfeed nnrpd[16096]: SERVER perl filter not defined
May 21 16:34:39 newsfeed nnrpd[16828]: SERVER perl filter not defined
May 21 17:30:28 newsfeed overchan[21070]: input line too long, skipping
May 21 18:06:44 newsfeed nnrpd[20187]: SERVER perl filter not defined
May 21 18:14:33 newsfeed nnrpd[20492]: SERVER perl filter not defined
May 21 18:18:36 newsfeed nnrpd[20587]: SERVER perl filter not defined
May 21 18:21:28 newsfeed nnrpd[20668]: SERVER perl filter not defined
May 21 18:28:45 newsfeed nnrpd[20950]: SERVER perl filter not defined
May 21 20:07:01 newsfeed nnrpd[24704]: SERVER perl filter not defined
May 21 22:46:54 newsfeed nnrpd[30667]: SERVER perl filter not defined
May 21 22:47:54 newsfeed nnrpd[30686]: SERVER perl filter not defined
May 21 23:39:09 newsfeed nnrpd[32566]: message repeated 3 times: [ 77-253-109-201.adsl.inetia.pl group lodz.test 0]
May 21 23:46:49 newsfeed nnrpd[434]: message repeated 2 times: [ 77-253-109-201.adsl.inetia.pl group lodz.test 0]

Log entries by program:

Program nameLines%LinesSize%Size
inn3210463 97.6%360.5 MB 97.2%
innfeed 49490 1.5%5.9 MB 1.6%
innd 22864 0.7%3.8 MB 1.0%
nnrpd 5655 0.2%624.5 KB 0.2%
overchan 3 0.0%0.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 63288476 100.0%370.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3200457 97.1%
Negative hits 86401 2.6%
Positive hits 10312 0.3%
Cache misses 167 0.0%
TOTAL: 4 3297337 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.125 0.0%305 0.000 6.967 37.000
article cleanup00:00:39.569 0.0%3211514 0.008 0.012 0.020
article logging00:01:58.121 0.1%3212066 0.025 0.037 0.112
article parse00:47:25.954 3.3%129233980 0.010 0.022 0.041
article write00:17:56.609 1.2%3206832 0.176 0.336 0.572
artlog/artcncl00:00:00.009 0.0%305 0.000 0.030 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:04:11.449 0.3%146080292 0.001 0.002 0.004
hisgrep/artcncl00:00:01.454 0.0%236 0.000 6.161 15.537
hishave/artcncl00:00:00.085 0.0%305 0.000 0.279 4.357
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:28:18.338 2.0%3306188 0.017 0.514 4.567
history sync00:00:00.020 0.0%291 0.000 0.069 0.500
history write01:38:36.726 6.8%3209357 0.129 1.844 10.372
hiswrite/artcncl00:00:00.012 0.0%69 0.000 0.174 2.000
idle13:57:55.132 58.2%104274519 0.310 0.482 1.791
nntp read01:18:36.089 5.5%126681552 0.022 0.037 0.068
overview write00:00:15.467 0.0%3206832 0.003 0.005 0.007
perl filter04:44:23.279 19.7%3209356 3.100 5.317 7.707
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:45.228 0.4%6432160 0.035 0.054 0.079
TOTAL: 24:00:05.78723:26:05.666 97.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.150 0.0%60391 0.000 0.002 0.014
article prepare00:00:00.003 0.0%2908 0.000 0.001 0.007
article read00:00:12.893 0.0%727 0.000 17.735 1703.000
backlog stats00:00:00.137 0.0%165246 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.359 0.0%85498 0.002 0.016 0.029
data write00:00:04.172 0.0%67685 0.017 0.062 0.262
idle23:53:10.383 99.9%165246 318.628 520.378 952.529
status file00:00:15.526 0.0%17131 0.550 0.906 1.361
TOTAL: 23:53:55.00423:53:44.623100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle06:12:46.908 99.9%4015 0.000 5570.836450136.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.129 0.0%69673 0.000 0.059 0.667
readart00:00:01.872 0.0%178 0.000 10.517 50.000
TOTAL: 06:13:13.16106:12:52.909 99.9%----

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 911 32046593196316 6291 2052 99%353:45:34
2news.nask.pl 2 12617 8345 1645 2627 66%24:17:37
3localhost 16 15 15 0 0 100%00:00:00
4news.icm.edu.pl 47 217 12 201 4 5%16:12:56
TOTAL: 4 976 32175083204688 8137 4683 99%394:16:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl720.7 GB13.9 MB21.2 MB720.7 GB 99%236.3 KB
2news.nask.pl32.3 MB708.0 KB17.3 MB50.3 MB 64%4.7 KB
3news.icm.edu.pl192.2 KB0.0 KB360.6 KB552.8 KB 34%34.5 KB
4localhost20.4 KB0.0 KB0.0 KB20.4 KB100%1.4 KB
TOTAL: 4720.7 GB14.6 MB38.9 MB720.8 GB 99%235.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 21 04:15:02 - 04:59:59 70557 2.2% 26.1516.4 GB 2.3%6391.06
May 21 05:00:00 - 05:59:59 93541 2.9% 25.9822.9 GB 3.2%6655.66
May 21 06:00:00 - 06:59:59 77391 2.4% 21.5018.0 GB 2.5%5241.92
May 21 07:00:00 - 07:59:59 92104 2.9% 25.5823.8 GB 3.3%6923.65
May 21 08:00:00 - 08:59:59 121124 3.8% 33.6532.4 GB 4.5%9442.00
May 21 09:00:00 - 09:59:59 129580 4.0% 35.9927.2 GB 3.8%7934.24
May 21 10:00:00 - 10:59:59 89936 2.8% 24.9824.0 GB 3.3%6985.76
May 21 11:00:00 - 11:59:59 108424 3.4% 30.1222.7 GB 3.1%6607.03
May 21 12:00:00 - 12:59:59 91460 2.9% 25.4126.7 GB 3.7%7783.54
May 21 13:00:00 - 13:59:59 156497 4.9% 43.4733.1 GB 4.6%9635.60
May 21 14:00:00 - 14:59:59 152622 4.8% 42.4027.0 GB 3.7%7860.08
May 21 15:00:00 - 15:59:59 243245 7.6% 67.5738.7 GB 5.4%11276.22
May 21 16:00:00 - 16:59:59 137932 4.3% 38.3134.9 GB 4.8%10155.16
May 21 17:00:00 - 17:59:59 135823 4.2% 37.7334.4 GB 4.8%10015.77
May 21 18:00:00 - 18:59:59 139280 4.3% 38.6936.9 GB 5.1%10734.04
May 21 19:00:00 - 19:59:59 145844 4.6% 40.5137.3 GB 5.2%10859.88
May 21 20:00:00 - 20:59:59 163002 5.1% 45.2838.1 GB 5.3%11089.65
May 21 21:00:00 - 21:59:59 222643 6.9% 61.8539.8 GB 5.5%11579.81
May 21 22:00:00 - 22:59:59 208617 6.5% 57.9539.9 GB 5.5%11618.76
May 21 23:00:00 - 23:59:59 164570 5.1% 45.7136.8 GB 5.1%10731.62
May 22 00:00:00 - 00:59:59 117304 3.7% 32.5820.6 GB 2.9%6011.76
May 22 01:00:00 - 01:59:59 103871 3.2% 28.8528.4 GB 3.9%8268.90
May 22 02:00:00 - 02:59:59 112560 3.5% 31.2728.2 GB 3.9%8206.00
May 22 03:00:00 - 03:59:59 102347 3.2% 28.4326.6 GB 3.7%7751.96
May 22 04:00:00 - 04:15:04 24662 0.8% 27.287.1 GB 1.0%8223.71
TOTAL: 24:00:02 3204936 100.0% 37.09721.7 GB 100.0%8759.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 2775 13 0 266 6 0 0 0 2490
2newsfeed.pionier.net.pl 2443 125 0 1878 2 0 0 0 438
3news.icm.edu.pl 4 0 0 0 0 0 0 0 4
TOTAL: 3 5222 138 0 2144 8 0 0 0 2932

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 53
it.comp.os.win.windows10 45
it.tlc.cellulari.android 17
comp.mobile.android 7
comp.sys.raspberry-pi 5
uk.rec.cycling.moderated 4
de.rec.sf.startrek 3
de.comp.office-pakete.ms-office.outlook 2
it.comp.os.win.windows8 2
TOTAL: 9 138

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) 2172
Binary in non-binary group 74
EMP (phl) 55
Scoring filter (8) 49
Scoring filter (9) 13
EMP (fsl) 7
HTML post 3
Scoring filter (10) 3
Scoring filter (11) 2
Scoring filter (16) 1
TOTAL: 10 2379

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 1
TOTAL: 1 1
Including strange strings
newsfeed.pionier.net.pl 391
news.nask.pl 161
TOTAL: 2 552
TOTAL: 2 553

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 26221 86 17909 369 0 0 0%24:00:00
2panorama 44193 84 15534 28 2 44998 0%24:00:00
3poznan 13200 23 8266 11 0 0 0%23:59:51
4nask 3688 4 2620 1 0 0 0%24:00:00
5okapi 0 0 0 0 0 870 0%23:57:52
TOTAL: 5 87302 197 44329 409 2 45868 0%119:57:43
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm9.8 MB124.7 MB134.5 MB1.6 KB/s302.7 KB24:00:00
2panorama817.0 KB230.6 KB1.0 MB0.0 KB/s9.4 KB24:00:00
3poznan77.3 KB37.7 KB115.0 KB0.0 KB/s3.4 KB23:59:51
4nask8.4 KB1.6 KB10.0 KB0.0 KB/s2.0 KB24:00:00
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
TOTAL: 510.7 MB125.0 MB135.7 MB0.3 KB/s229.2 KB119:57:43
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1public-gprs363533.centertel.pl 17 5144.5 KB 8 0 1300:33:47
287-205-39-97.adsl.inetia.pl 15 4235.3 KB 3 0 1200:38:07
377-253-109-201.adsl.inetia.pl 43 1816.9 KB 6 0 3001:18:37
4wireless.ics.p.lodz.pl 3 1713.7 KB 5 2 001:19:43
50890788407.static.corbina.ru 11 1520.5 KB 6 0 000:01:39
6web.man.lodz.pl 288 1412.3 KB 5 0 000:00:20
7178.43.253.92.ipv4.supernova.orange.pl 5 33.0 KB 3 0 001:46:33
8user-94-254-130-249.play-internet.pl 1 32.4 KB 1 0 000:30:07
9isvcs01.man.lodz.pl 13 00.0 KB 0 13 000:00:03
TOTAL: 9 396 163148.5 KB 37 15 5506:13:12

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.adsl.inetia.pl 58 6052.2 KB 9 0 4201:56:44
2*.centertel.pl 17 5144.5 KB 8 0 1300:33:47
3*.ics.p.lodz.pl 3 1713.7 KB 5 2 001:19:43
4*.static.corbina.ru 11 1520.5 KB 6 0 000:01:39
5*.man.lodz.pl 685 1412.3 KB 5 13 000:00:28
6*.play-internet.pl 1 32.4 KB 1 0 000:30:07
7*.43.253.92.ipv4.supernova.orange.pl 5 33.0 KB 3 0 001:46:33
8*.43.168.101.ipv4.supernova.orange.pl 2 00.0 KB 0 0 000:04:07
TOTAL: 8 782 163148.5 KB 37 15 5506:13:12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
178.43.253.92.ipv4.supernova.orange.pl 0.016 0.076 0.00001:46:33
wireless.ics.p.lodz.pl 0.200 0.160 0.00001:19:43
77-253-109-201.adsl.inetia.pl 0.520 0.916 0.00001:18:37
87-205-39-97.adsl.inetia.pl 0.176 0.272 0.00000:38:07
public-gprs363533.centertel.pl 0.364 0.460 0.00000:33:47
user-94-254-130-249.play-internet.pl 0.004 0.016 0.00000:30:07
178.43.168.101.ipv4.supernova.orange.pl 0.048 0.052 0.00000:04:07
0890788407.static.corbina.ru 0.040 0.248 0.00000:01:39
web.man.lodz.pl 1.664 4.928 0.00000:00:20
mon.man.lodz.pl 1.224 4.580 0.00000:00:03
isvcs01.man.lodz.pl 0.116 0.240 0.00000:00:03
david.man.lodz.pl 0.340 1.304 0.00000:00:01
TOTAL: 12 4.712 13.252 0.00006:13:12

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
178.43.168.101.ipv4.supernova.orange.pl 2
TOTAL: 3 386

NNRP client timeouts [Top 20]:

SystemConnPeer
wireless.ics.p.lodz.pl 2 0
178.43.253.92.ipv4.supernova.orange.pl 2 0
user-94-254-130-249.play-internet.pl 1 0
TOTAL: 3 5 0

Newsgroup request counts (by category):

CategoryCountPct
1lodz 129 79.1%
2lodman 16 9.8%
3pl 14 8.6%
4lodzman 4 2.5%
TOTAL: 4 163100.0%

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

NewsgroupCount
1lodz.test 129
2lodman.info 13
3pl.comp.pecet 12
4lodzman.test 4
5lodman.test 3
6pl.comp.os.ms-windows.winnt 2
TOTAL: 6 163