Daily Usenet report

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

Unknown entries from news log file:

First 48 / 48 lines (100.0%)

Oct 24 10:44:55 newsfeed overchan[9411]: input line too long, skipping
Oct 24 10:45:14 newsfeed overchan[9411]: input line too long, skipping
Oct 24 12:43:52 newsfeed overchan[9411]: input line too long, skipping
Oct 24 12:50:19 newsfeed overchan[9411]: input line too long, skipping
Oct 24 12:52:10 newsfeed overchan[9411]: input line too long, skipping
Oct 24 12:54:05 newsfeed overchan[9411]: input line too long, skipping
Oct 24 12:55:51 newsfeed overchan[9411]: input line too long, skipping
Oct 24 12:59:38 newsfeed overchan[9411]: input line too long, skipping
Oct 24 13:02:29 newsfeed overchan[9411]: input line too long, skipping
Oct 24 13:05:04 newsfeed overchan[9411]: input line too long, skipping
Oct 24 13:08:56 newsfeed overchan[9411]: input line too long, skipping
Oct 24 13:10:26 newsfeed overchan[9411]: input line too long, skipping
Oct 24 13:15:03 newsfeed overchan[9411]: input line too long, skipping
Oct 24 13:18:33 newsfeed overchan[9411]: input line too long, skipping
Oct 24 13:36:10 newsfeed overchan[9411]: input line too long, skipping
Oct 24 14:30:34 newsfeed nnrpd[3563]: SERVER perl filter not defined
Oct 24 16:34:57 newsfeed overchan[9411]: input line too long, skipping
Oct 24 16:37:48 newsfeed overchan[9411]: input line too long, skipping
Oct 24 16:39:04 newsfeed overchan[9411]: input line too long, skipping
Oct 24 16:42:36 newsfeed overchan[9411]: input line too long, skipping
Oct 24 16:44:48 newsfeed nnrpd[9115]: SERVER perl filter not defined
Oct 24 16:48:08 newsfeed overchan[9411]: input line too long, skipping
Oct 24 16:55:56 newsfeed overchan[9411]: input line too long, skipping
Oct 24 17:01:18 newsfeed overchan[9411]: input line too long, skipping
Oct 24 17:07:26 newsfeed overchan[9411]: input line too long, skipping
Oct 24 17:35:39 newsfeed innfeed[1035]: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Oct 24 17:35:39 newsfeed innfeed[1035]: SM: storage method 'cnfs' failed initialization
Oct 24 17:35:39 newsfeed innfeed[1035]: SM: one or more storage methods failed initialization
Oct 24 17:35:39 newsfeed innfeed[1035]: Storage manager initialization failed -- it is OK after a change in storage methods
Oct 24 17:35:40 newsfeed innd: CNFS: Mismatch 3: read BUF04 for cycbuff BUF03
Oct 24 17:35:40 newsfeed innd: SM: storage method 'cnfs' failed initialization
Oct 24 17:35:40 newsfeed innd: SM: one or more storage methods failed initialization
Oct 24 17:47:50 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Oct 24 19:00:05 newsfeed overchan[1003]: input line too long, skipping
Oct 24 20:01:52 newsfeed overchan[1003]: input line too long, skipping
Oct 24 20:11:59 newsfeed overchan[1003]: input line too long, skipping
Oct 24 21:16:47 newsfeed nnrpd[15870]: SERVER perl filter not defined
Oct 24 21:20:13 newsfeed nnrpd[16128]: SERVER perl filter not defined
Oct 24 21:21:28 newsfeed nnrpd[16144]: SERVER perl filter not defined
Oct 24 21:35:04 newsfeed overchan[1003]: input line too long, skipping
Oct 24 22:57:22 newsfeed overchan[1003]: input line too long, skipping
Oct 25 00:14:13 newsfeed nnrpd[22987]: SERVER perl filter not defined
Oct 25 00:28:11 newsfeed nnrpd[23488]: SERVER perl filter not defined
Oct 25 00:36:22 newsfeed overchan[1003]: input line too long, skipping
Oct 25 02:50:46 newsfeed nnrpd[29269]: SERVER perl filter not defined
Oct 25 02:53:42 newsfeed nnrpd[29319]: SERVER perl filter not defined
Oct 25 02:59:53 newsfeed overchan[1003]: input line too long, skipping
Oct 25 03:00:16 newsfeed overchan[1003]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2702998 97.5%310.8 MB 97.2%
innfeed 46113 1.7%5.4 MB 1.7%
innd 17249 0.6%2.9 MB 0.9%
nnrpd 4915 0.2%527.3 KB 0.2%
overchan 33 0.0%5.7 KB 0.0%
controlchan 4 0.0%0.3 KB 0.0%
TOTAL: 62771312 100.0%319.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2660320 93.2%
Positive hits 118214 4.1%
Negative hits 76152 2.7%
Cache misses 679 0.0%
TOTAL: 4 2855365 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.687 0.0%142 0.000 33.007 224.667
article cleanup00:00:38.096 0.0%2687492 0.010 0.014 0.020
article logging00:02:05.770 0.1%2687949 0.033 0.047 0.072
article parse00:49:58.053 3.5%78334409 0.022 0.038 0.052
article write00:18:06.640 1.3%2668204 0.230 0.407 0.627
artlog/artcncl00:00:00.004 0.0%142 0.000 0.028 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:00.464 0.2%91919630 0.001 0.002 0.004
hisgrep/artcncl00:00:01.378 0.0%141 0.000 9.773 23.024
hishave/artcncl00:00:00.232 0.0%142 0.000 1.634 15.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:28:41.287 10.5%2866205 0.829 3.113 6.391
history sync00:00:00.023 0.0%286 0.000 0.080 0.500
history write04:01:59.670 17.0%2670237 2.148 5.438 9.003
hiswrite/artcncl00:00:00.013 0.0%1 13.000 13.000 13.000
idle09:27:01.032 39.9%51855320 0.312 0.656 1.793
nntp read01:10:05.844 4.9%76277444 0.037 0.055 0.076
overview write00:00:14.157 0.0%2668204 0.004 0.005 0.007
perl filter04:48:25.947 20.3%2670235 4.600 6.481 8.685
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:49.784 0.4%5514783 0.047 0.063 0.082
TOTAL: 23:40:04.09323:16:13.081 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.158 0.0%356344 0.000 0.003 0.009
article prepare00:00:00.041 0.0%182658 0.000 0.000 0.005
article read00:00:25.554 0.0%43372 0.000 0.589 63.333
backlog stats00:00:01.275 0.0%1214642 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:15.221 0.0%670384 0.009 0.023 0.035
data write00:02:19.159 0.2%603921 0.056 0.230 0.621
idle23:27:16.754 99.7%1214642 26.455 69.516 411.490
status file00:00:23.064 0.0%16959 0.708 1.360 9.767
TOTAL: 23:31:28.31223:30:42.226 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:37.726 38.4%3121 0.000 12.088 9486.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.545 0.6%6965 0.000 0.078 4.947
readart00:00:00.428 0.4%87 0.000 4.920 9.043
TOTAL: 00:01:38.26700:00:38.699 39.4%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 153
name 6
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 201

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 263 26764282669979 1566 4883 99%292:23:58
2news.nask.pl 2 124662 11920 98461 14281 9%23:14:07
3news.icm.edu.pl 38 344 160 140 44 46%18:56:48
4localhost 10 9 9 0 0 100%00:00:00
TOTAL: 4 313 28014432682068 100167 19208 95%334:34:53
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl680.6 GB820.8 MB839.0 MB682.2 GB 99%267.4 KB
2news.nask.pl2.7 GB3.7 GB3.7 GB10.0 GB 26%401.0 KB
3news.icm.edu.pl3.3 MB84.9 KB1.1 MB4.4 MB 74%22.1 KB
4localhost13.4 KB0.0 KB0.0 KB13.4 KB100%1.5 KB
TOTAL: 4683.3 GB4.5 GB4.5 GB692.2 GB 98%268.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 24 04:15:03 - 04:59:59 74178 2.8% 27.5022.8 GB 3.3%8868.49
Oct 24 05:00:00 - 05:59:59 83089 3.1% 23.0826.2 GB 3.8%7622.83
Oct 24 06:00:00 - 06:59:59 111560 4.2% 30.9929.5 GB 4.3%8579.83
Oct 24 07:00:00 - 07:59:59 98914 3.7% 27.4832.9 GB 4.8%9572.07
Oct 24 08:00:00 - 08:59:59 74222 2.8% 20.6222.3 GB 3.3%6489.64
Oct 24 09:00:00 - 09:59:59 112441 4.2% 31.2324.9 GB 3.6%7255.55
Oct 24 10:00:00 - 10:59:59 129235 4.8% 35.9029.0 GB 4.2%8436.66
Oct 24 11:00:00 - 11:59:59 110906 4.1% 30.8129.0 GB 4.2%8444.90
Oct 24 12:00:00 - 12:59:59 141205 5.3% 39.2232.4 GB 4.7%9437.01
Oct 24 13:00:00 - 13:59:59 148066 5.5% 41.1336.7 GB 5.4%10694.72
Oct 24 14:00:00 - 14:59:59 121802 4.5% 33.8332.7 GB 4.8%9533.19
Oct 24 15:00:00 - 15:59:59 114771 4.3% 31.8832.8 GB 4.8%9558.25
Oct 24 16:00:00 - 16:59:59 107934 4.0% 29.9827.4 GB 4.0%7977.23
Oct 24 17:00:00 - 17:59:59 101042 3.8% 28.0723.5 GB 3.4%6831.51
Oct 24 18:00:00 - 18:59:59 159980 6.0% 44.4433.9 GB 5.0%9877.00
Oct 24 19:00:00 - 19:59:59 144724 5.4% 40.2033.2 GB 4.9%9678.34
Oct 24 20:00:00 - 20:59:59 85164 3.2% 23.6615.1 GB 2.2%4392.01
Oct 24 21:00:00 - 21:59:59 100912 3.8% 28.0321.9 GB 3.2%6373.31
Oct 24 22:00:00 - 22:59:59 100513 3.7% 27.9224.4 GB 3.6%7093.33
Oct 24 23:00:00 - 23:59:59 104681 3.9% 29.0823.6 GB 3.5%6886.13
Oct 25 00:00:00 - 00:59:59 107187 4.0% 29.7727.9 GB 4.1%8116.68
Oct 25 01:00:00 - 01:59:59 123056 4.6% 34.1835.2 GB 5.2%10255.95
Oct 25 02:00:00 - 02:59:59 120170 4.5% 33.3833.8 GB 5.0%9857.65
Oct 25 03:00:00 - 03:59:59 84982 3.2% 23.6125.2 GB 3.7%7339.26
Oct 25 04:00:00 - 04:15:02 22294 0.8% 24.727.5 GB 1.1%8761.52
TOTAL: 23:59:59 2683028 100.0% 31.05683.7 GB 100.0%8297.69
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 14534 5 0 12746 2 0 0 0 1781
2newsfeed.pionier.net.pl 5250 196 0 4543 1 0 0 0 510
3news.icm.edu.pl 44 0 0 8 0 0 0 0 36
TOTAL: 3 19828 201 0 17297 3 0 0 0 2327

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 132
it.tlc.cellulari.android 32
it.comp.os.win.windows10 22
de.comp.os.os2 5
de.comm.software.mailreader 4
comp.mobile.android 3
uk.rec.cycling.moderated 1
it.politica.m5s 1
it.comp.os.win.windows7 1
TOTAL: 9 201

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1543
Binary in non-binary group 195
EMP (phl) 58
Scoring filter (16) 21
Scoring filter (9) 19
Scoring filter (8) 8
HTML post 7
Too many newsgroups 3
Scoring filter (11) 2
Scoring filter (10) 2
Scoring filter (18) 2
EMP (fsl) 1
TOTAL: 12 1861

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 2
TOTAL: 1 2
Including strange strings
newsfeed.pionier.net.pl 362
news.nask.pl 102
TOTAL: 2 464
TOTAL: 2 466

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 227191 39880 118048 1509 0 7 17%23:36:39
2panorama 191528 798 162497 191 5 195949 0%23:47:26
3poznan 5632 109 3958 21 0 0 1%23:37:42
4icm 192400 46 174975 3072 0 0 0%23:36:39
5okapi 0 0 0 0 0 981 0%23:34:32
TOTAL: 5 616751 40833 459478 4793 5 196937 6%118:12:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask13.4 GB521.0 MB13.9 GB172.1 KB/s353.4 KB23:36:39
2panorama7.2 MB2.7 MB9.9 MB0.1 KB/s10.2 KB23:47:26
3icm4.7 MB1.0 GB1.0 GB12.7 KB/s346.9 KB23:36:39
4poznan445.3 KB92.0 KB537.2 KB0.0 KB/s4.1 KB23:37:42
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:34:32
TOTAL: 513.5 GB1.5 GB15.0 GB36.9 KB/s344.5 KB118:12:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ool-4578089a.dyn.optonline.net 1 4729.8 KB 1 0 000:00:09
2web.man.lodz.pl 285 4039.1 KB 16 0 000:00:26
3isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:04
TOTAL: 3 295 8768.9 KB 17 9 000:01:37

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dyn.optonline.net 1 4729.8 KB 1 0 000:00:09
2*.man.lodz.pl 579 4039.1 KB 16 9 000:00:35
3unresolved 104 00.0 KB 0 0 000:00:51
TOTAL: 3 684 8768.9 KB 17 9 000:01:37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
164.52.24.176 0.036 0.212 0.00000:00:40
web.man.lodz.pl 1.600 6.544 0.00000:00:26
ool-4578089a.dyn.optonline.net 0.020 0.064 0.00000:00:09
107.170.219.69 0.012 0.020 0.00000:00:09
isvcs01.man.lodz.pl 0.088 0.184 0.00000:00:04
mon.man.lodz.pl 1.336 5.372 0.00000:00:04
212.51.192.185 0.476 1.792 0.00000:00:01
TOTAL: 7 3.568 14.188 0.00000:01:37

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 285
212.51.192.185 95
164.52.24.176 8
107.170.219.69 1
TOTAL: 4 389

NNRP unrecognized commands (by host):

SystemConn
164.52.24.176 6
TOTAL: 1 6

NNRP unrecognized commands (by command):

CommandCount
À/À+À'À#À#023À 1
#026#003#001#001"#001 1
fox a 1 -1 fox hello 1
@RSYNCD: 29 1
GET / HTTP/1.1 1
W 1
TOTAL: 6 6

Newsgroup request counts (by category):

CategoryCountPct
1lodman 47 54.0%
2pl 40 46.0%
TOTAL: 2 87100.0%

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

NewsgroupCount
1lodman.info 47
2pl.comp.os.ms-windows.winnt 24
3pl.comp.pecet 16
TOTAL: 3 87
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>