Daily Usenet report

Oct 25 04:15:02 -- Oct 26 04:15:03

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Oct 25 07:13:17 newsfeed overchan[32695]: input line too long, skipping
Oct 25 07:21:32 newsfeed overchan[32695]: input line too long, skipping
Oct 25 07:28:13 newsfeed overchan[32695]: input line too long, skipping
Oct 25 07:41:00 newsfeed overchan[32695]: input line too long, skipping
Oct 25 08:54:48 newsfeed overchan[32695]: input line too long, skipping
Oct 25 10:33:04 newsfeed nnrpd[16466]: SERVER perl filter not defined
Oct 25 10:42:07 newsfeed overchan[32695]: input line too long, skipping
Oct 25 11:46:05 newsfeed overchan[32695]: input line too long, skipping
Oct 25 12:41:30 newsfeed nnrpd[21583]: SERVER perl filter not defined
Oct 25 15:51:40 newsfeed overchan[32695]: input line too long, skipping
Oct 25 15:51:56 newsfeed overchan[32695]: input line too long, skipping
Oct 25 18:10:04 newsfeed overchan[32695]: input line too long, skipping
Oct 25 19:50:11 newsfeed overchan[32695]: input line too long, skipping
Oct 25 20:16:36 newsfeed nnrpd[17160]: SERVER perl filter not defined
Oct 25 21:10:29 newsfeed overchan[32695]: input line too long, skipping
Oct 25 22:37:14 newsfeed overchan[32695]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2742423 97.6%316.8 MB 97.3%
innfeed 45984 1.6%5.5 MB 1.7%
innd 17501 0.6%2.9 MB 0.9%
nnrpd 4908 0.2%521.3 KB 0.2%
overchan 14 0.0%2.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62810831 100.0%325.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2712733 92.7%
Positive hits 125479 4.3%
Negative hits 87592 3.0%
Cache misses 488 0.0%
TOTAL: 4 2926292 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:07.056 0.0%225 0.000 31.360 96.182
article cleanup00:00:39.243 0.0%2744259 0.009 0.014 0.018
article logging00:02:17.806 0.2%2744711 0.034 0.050 0.095
article parse00:51:48.542 3.6%78532174 0.026 0.040 0.052
article write00:19:38.086 1.4%2727006 0.240 0.432 0.664
artlog/artcncl00:00:00.010 0.0%225 0.000 0.044 0.500
data move00:05:05.149 0.4%92355143 0.002 0.003 0.005
hisgrep/artcncl00:00:03.072 0.0%223 0.000 13.776 38.212
hishave/artcncl00:00:00.969 0.0%225 0.000 4.307 56.364
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:50:15.562 7.7%2943982 0.787 2.247 5.328
history sync00:00:00.021 0.0%290 0.000 0.072 1.000
history write04:38:19.026 19.3%2728759 2.388 6.120 12.248
hiswrite/artcncl00:00:00.002 0.0%2 0.000 1.000 2.000
idle09:08:06.991 38.1%51435877 0.326 0.639 1.378
nntp read01:23:08.008 5.8%76437524 0.052 0.065 0.077
overview write00:00:15.813 0.0%2727006 0.004 0.006 0.008
perl filter05:10:51.960 21.6%2728752 4.549 6.835 9.046
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:06:41.116 0.5%5651687 0.054 0.071 0.086
TOTAL: 24:00:02.50723:37:18.432 98.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.495 0.0%406136 0.000 0.004 0.054
article prepare00:00:00.068 0.0%221036 0.000 0.000 0.003
article read00:00:30.580 0.0%53811 0.093 0.568 3.441
backlog stats00:00:01.365 0.0%1332872 0.000 0.001 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:18.817 0.0%762089 0.017 0.025 0.034
data write00:02:31.743 0.2%656143 0.104 0.231 0.393
idle23:46:08.101 99.7%1332872 37.875 64.198 130.181
status file00:00:23.096 0.0%17468 0.903 1.322 17.407
TOTAL: 23:50:50.48723:49:55.265 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.702 52.2%3103 0.000 6.349 50.778
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.469 1.2%6966 0.000 0.067 3.000
readart00:00:00.018 0.0%102 0.000 0.176 2.500
TOTAL: 00:00:37.76500:00:20.189 53.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 377 27212852715568 1692 4025 99%344:29:16
2news.nask.pl 2 132233 8651 110362 13220 6%24:08:11
3news.icm.edu.pl 44 236 91 109 36 38%14:20:30
4localhost 4 3 3 0 0 100%00:00:00
TOTAL: 4 427 28537572724313 112163 17281 95%382:57:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl693.6 GB543.9 MB569.5 MB694.7 GB 99%267.8 KB
2news.nask.pl1.6 GB3.4 GB3.4 GB8.5 GB 19%407.9 KB
3news.icm.edu.pl1.9 MB138.5 KB1.3 MB3.4 MB 57%27.1 KB
4localhost5.7 KB0.0 KB0.0 KB5.7 KB100%1.9 KB
TOTAL: 4695.2 GB4.0 GB4.0 GB703.2 GB 98%268.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 25 04:15:02 - 04:59:59 90273 3.3% 33.4626.8 GB 3.8%10407.26
Oct 25 05:00:00 - 05:59:59 99793 3.7% 27.7229.8 GB 4.3%8678.00
Oct 25 06:00:00 - 06:59:59 90266 3.3% 25.0728.2 GB 4.0%8199.61
Oct 25 07:00:00 - 07:59:59 105180 3.9% 29.2233.2 GB 4.8%9682.61
Oct 25 08:00:00 - 08:59:59 90255 3.3% 25.0730.0 GB 4.3%8725.39
Oct 25 09:00:00 - 09:59:59 102942 3.8% 28.5932.6 GB 4.7%9484.91
Oct 25 10:00:00 - 10:59:59 117309 4.3% 32.5936.4 GB 5.2%10608.32
Oct 25 11:00:00 - 11:59:59 133959 4.9% 37.2130.7 GB 4.4%8950.25
Oct 25 12:00:00 - 12:59:59 99191 3.6% 27.5524.8 GB 3.6%7232.68
Oct 25 13:00:00 - 13:59:59 147775 5.4% 41.0529.1 GB 4.2%8468.25
Oct 25 14:00:00 - 14:59:59 171851 6.3% 47.7433.3 GB 4.8%9697.82
Oct 25 15:00:00 - 15:59:59 113992 4.2% 31.6628.5 GB 4.1%8309.61
Oct 25 16:00:00 - 16:59:59 106366 3.9% 29.5526.4 GB 3.8%7692.52
Oct 25 17:00:00 - 17:59:59 107604 3.9% 29.8930.0 GB 4.3%8746.80
Oct 25 18:00:00 - 18:59:59 157689 5.8% 43.8037.1 GB 5.3%10792.57
Oct 25 19:00:00 - 19:59:59 92937 3.4% 25.8223.8 GB 3.4%6925.86
Oct 25 20:00:00 - 20:59:59 100278 3.7% 27.8620.2 GB 2.9%5876.79
Oct 25 21:00:00 - 21:59:59 99132 3.6% 27.5420.0 GB 2.9%5814.05
Oct 25 22:00:00 - 22:59:59 134546 4.9% 37.3732.1 GB 4.6%9339.04
Oct 25 23:00:00 - 23:59:59 133094 4.9% 36.9730.6 GB 4.4%8899.07
Oct 26 00:00:00 - 00:59:59 122529 4.5% 34.0427.7 GB 4.0%8079.58
Oct 26 01:00:00 - 01:59:59 112322 4.1% 31.2032.4 GB 4.7%9426.75
Oct 26 02:00:00 - 02:59:59 90554 3.3% 25.1525.6 GB 3.7%7447.41
Oct 26 03:00:00 - 03:59:59 86325 3.2% 23.9821.9 GB 3.1%6373.58
Oct 26 04:00:00 - 04:15:03 18343 0.7% 20.314.9 GB 0.7%5737.52
TOTAL: 24:00:01 2724505 100.0% 31.53695.9 GB 100.0%8445.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 13246 6 0 11863 2 0 0 0 1375
2newsfeed.pionier.net.pl 4410 242 0 3620 2 0 0 0 546
3news.icm.edu.pl 37 0 0 5 0 0 0 0 32
TOTAL: 3 17693 248 0 15488 4 0 0 0 1953

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 171
it.comp.os.win.windows10 41
it.tlc.cellulari.android 13
comp.mobile.ipad 12
comp.mobile.android 5
uk.rec.cycling.moderated 3
de.comp.os.os2 1
de.comm.software.mailreader 1
de.comp.lang.vbclassic 1
TOTAL: 9 248

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

GroupsCount
pl.sci.matematyka 2
pl.praca.oferowana 1
bit.listserv.catholic 1
TOTAL: 3 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1222
Binary in non-binary group 176
EMP (phl) 24
Scoring filter (16) 20
Scoring filter (8) 20
Scoring filter (9) 17
Scoring filter (10) 7
Scoring filter (18) 2
HTML post 1
Scoring filter (15) 1
EMP (fsl) 1
Too many newsgroups 1
Scoring filter (13) 1
Scoring filter (12) 1
TOTAL: 14 1494

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 373
news.nask.pl 77
news.icm.edu.pl 1
TOTAL: 3 451
TOTAL: 2 452

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 263352 52552 128880 481 0 5 19%23:59:57
2panorama 223687 382 194931 83 2 213591 0%23:59:58
3poznan 5636 49 3926 15 0 1 0%23:59:57
4icm 210928 44 195431 1597 0 2 0%23:59:57
5okapi 0 0 0 0 0 1056 0%23:57:50
TOTAL: 5 703603 53027 523168 2176 2 214655 7%119:57:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask17.7 GB164.4 MB17.9 GB216.9 KB/s353.4 KB23:59:57
2icm4.1 MB550.6 MB554.7 MB6.6 KB/s346.1 KB23:59:57
3panorama1.8 MB645.5 KB2.4 MB0.0 KB/s5.3 KB23:59:58
4poznan326.8 KB68.1 KB394.9 KB0.0 KB/s6.2 KB23:59:57
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 517.7 GB715.7 MB18.4 GB44.7 KB/s349.8 KB119:57:39
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 10286.5 KB 45 0 000:00:28
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:01
TOTAL: 2 291 10286.5 KB 45 3 000:00:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 579 10286.5 KB 45 3 000:00:35
2unresolved 96 00.0 KB 0 0 000:00:01
TOTAL: 2 675 10286.5 KB 45 3 000:00:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.800 5.516 0.00000:00:28
mon.man.lodz.pl 1.412 4.408 0.00000:00:04
isvcs01.man.lodz.pl 0.032 0.072 0.00000:00:01
212.51.192.185 0.476 1.436 0.00000:00:01
TOTAL: 4 3.720 11.432 0.00000:00:36

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
TOTAL: 2 384

Newsgroup request counts (by category):

CategoryCountPct
1pl 102100.0%
TOTAL: 1 102100.0%

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

NewsgroupCount
1pl.comp.pecet 80
2pl.comp.os.ms-windows.winnt 22
TOTAL: 2 102