Daily Usenet report

Jan 1 04:15:02 -- Jan 2 04:15:03

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Jan 1 04:35:51 newsfeed overchan[9860]: input line too long, skipping
Jan 1 05:03:54 newsfeed overchan[9860]: input line too long, skipping
Jan 1 07:33:31 newsfeed overchan[9860]: input line too long, skipping
Jan 1 07:34:31 newsfeed overchan[9860]: input line too long, skipping
Jan 1 10:05:06 newsfeed nnrpd[23445]: SERVER perl filter not defined
Jan 1 10:07:58 newsfeed nnrpd[23490]: SERVER perl filter not defined
Jan 1 10:47:55 newsfeed nnrpd[24931]: SERVER perl filter not defined
Jan 1 10:50:25 newsfeed overchan[9860]: input line too long, skipping
Jan 1 11:04:58 newsfeed overchan[9860]: input line too long, skipping
Jan 1 11:14:47 newsfeed overchan[9860]: input line too long, skipping
Jan 1 11:15:13 newsfeed nnrpd[25993]: SERVER perl filter not defined
Jan 1 11:42:10 newsfeed nnrpd[27036]: SERVER perl filter not defined
Jan 1 11:54:11 newsfeed nnrpd[27411]: SERVER perl filter not defined
Jan 1 11:58:41 newsfeed overchan[9860]: input line too long, skipping
Jan 1 18:12:47 newsfeed overchan[9860]: input line too long, skipping
Jan 1 18:17:46 newsfeed overchan[9860]: input line too long, skipping
Jan 1 18:30:02 newsfeed overchan[9860]: input line too long, skipping
Jan 2 01:15:03 newsfeed pgpverify[24134]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn3201600 98.1%364.1 MB 97.7%
innfeed 37422 1.1%4.4 MB 1.2%
innd 20949 0.6%3.5 MB 0.9%
nnrpd 4788 0.1%507.9 KB 0.1%
overchan 12 0.0%1.9 KB 0.0%
controlchan 4 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 73264776 100.0%372.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3161932 96.4%
Negative hits 107083 3.3%
Positive hits 9917 0.3%
Cache misses 214 0.0%
TOTAL: 4 3279146 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:07.566 0.0%171 0.000 44.246 366.000
article cleanup00:00:37.436 0.0%3210405 0.008 0.012 0.016
article logging00:02:06.253 0.1%3211308 0.027 0.039 0.140
article parse00:42:52.273 3.0%81472809 0.019 0.032 0.057
article write00:16:30.610 1.1%3205205 0.197 0.309 0.501
artlog/artcncl00:00:00.008 0.0%163 0.000 0.049 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:38.650 0.2%95754557 0.001 0.002 0.003
hisgrep/artcncl00:00:01.519 0.0%159 0.000 9.553 86.091
hishave/artcncl00:00:00.719 0.0%171 0.000 4.205 24.111
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:35:14.729 10.8%3327980 0.324 2.799 13.157
history sync00:00:00.012 0.0%290 0.000 0.041 0.500
history write06:05:11.302 25.4%3207700 1.118 6.831 21.712
hiswrite/artcncl00:00:00.048 0.0%12 0.000 4.000 25.000
idle07:55:32.732 33.0%51487454 0.071 0.554 1.174
nntp read00:46:54.695 3.3%78886417 0.026 0.036 0.057
overview write00:00:16.382 0.0%3205205 0.004 0.005 0.008
perl filter05:01:09.615 20.9%3207675 4.580 5.633 8.153
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:52.080 0.3%6429653 0.034 0.045 0.064
TOTAL: 24:00:06.73423:34:06.629 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.146 0.0%55609 0.000 0.003 0.016
article prepare00:00:00.003 0.0%14382 0.000 0.000 0.001
article read00:00:32.087 0.0%3586 0.000 8.948 349.667
backlog stats00:00:00.152 0.0%158887 0.000 0.001 0.009
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.369 0.0%83368 0.000 0.016 0.037
data write00:00:06.259 0.0%70925 0.016 0.088 0.282
idle23:53:29.087 99.9%158887 91.985 541.322 2113.227
status file00:00:37.960 0.0%12965 0.000 2.928 231.500
TOTAL: 23:55:01.87923:54:47.063100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.050 0.0%24 2.083 2.083 2.083
idle44:04:43.670 99.9%1370230 0.000 115.808 116.057
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:01:22.430 0.1%2741080 0.000 0.030 0.667
readart00:00:00.005 0.0%46 0.000 0.109 1.000
TOTAL: 44:07:44.75744:06:06.155 99.9%----

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 513 31949913186009 6204 2778 99%535:27:30
2news.nask.pl 2 12805 9378 983 2444 73%24:18:05
3news.icm.edu.pl 47 235 33 195 7 14%16:20:05
4localhost 7 6 6 0 0 100%00:00:00
TOTAL: 4 569 32080373195426 7382 5229 99%576:05:40
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl651.9 GB32.0 MB45.6 MB652.0 GB 99%214.4 KB
2news.nask.pl49.1 MB645.2 KB31.8 MB81.5 MB 60%7.1 KB
3news.icm.edu.pl1.1 MB0.0 KB286.1 KB1.4 MB 80%36.4 KB
4localhost9.3 KB0.0 KB0.0 KB9.3 KB100%1.6 KB
TOTAL: 4652.0 GB32.6 MB77.7 MB652.1 GB 99%213.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 1 04:15:02 - 04:59:59 76260 2.4% 28.2716.5 GB 2.5%6407.92
Jan 1 05:00:00 - 05:59:59 103050 3.2% 28.6224.4 GB 3.7%7111.56
Jan 1 06:00:00 - 06:59:59 99846 3.1% 27.7320.7 GB 3.2%6031.14
Jan 1 07:00:00 - 07:59:59 92156 2.9% 25.6022.0 GB 3.4%6411.94
Jan 1 08:00:00 - 08:59:59 75966 2.4% 21.1020.8 GB 3.2%6057.66
Jan 1 09:00:00 - 09:59:59 105425 3.3% 29.2827.2 GB 4.2%7923.04
Jan 1 10:00:00 - 10:59:59 131572 4.1% 36.5532.7 GB 5.0%9513.90
Jan 1 11:00:00 - 11:59:59 110173 3.4% 30.6025.5 GB 3.9%7432.85
Jan 1 12:00:00 - 12:59:59 119867 3.8% 33.3029.3 GB 4.5%8545.43
Jan 1 13:00:00 - 13:59:59 96764 3.0% 26.8822.4 GB 3.4%6517.74
Jan 1 14:00:00 - 14:59:59 120190 3.8% 33.3920.8 GB 3.2%6067.46
Jan 1 15:00:00 - 15:59:59 115642 3.6% 32.1220.7 GB 3.2%6015.88
Jan 1 16:00:00 - 16:59:59 157611 4.9% 43.7825.8 GB 4.0%7510.17
Jan 1 17:00:00 - 17:59:59 219901 6.9% 61.0829.6 GB 4.5%8612.41
Jan 1 18:00:00 - 18:59:59 162752 5.1% 45.2130.0 GB 4.6%8729.98
Jan 1 19:00:00 - 19:59:59 158852 5.0% 44.1335.7 GB 5.5%10407.48
Jan 1 20:00:00 - 20:59:59 157319 4.9% 43.7030.7 GB 4.7%8927.74
Jan 1 21:00:00 - 21:59:59 168260 5.3% 46.7431.4 GB 4.8%9140.65
Jan 1 22:00:00 - 22:59:59 122242 3.8% 33.9624.0 GB 3.7%6996.77
Jan 1 23:00:00 - 23:59:59 120871 3.8% 33.5825.0 GB 3.8%7295.23
Jan 2 00:00:00 - 00:59:59 150848 4.7% 41.9026.4 GB 4.1%7693.78
Jan 2 01:00:00 - 01:59:59 174107 5.4% 48.3632.9 GB 5.1%9596.00
Jan 2 02:00:00 - 02:59:59 172226 5.4% 47.8437.8 GB 5.8%11008.54
Jan 2 03:00:00 - 03:59:59 150384 4.7% 41.7732.9 GB 5.1%9596.84
Jan 2 04:00:00 - 04:15:03 33052 1.0% 36.606.8 GB 1.0%7929.91
TOTAL: 24:00:01 3195336 100.0% 36.98652.1 GB 100.0%7913.89
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3385 158 0 2455 1 0 0 0 771
2news.nask.pl 2709 18 0 251 1 0 0 0 2439
3news.icm.edu.pl 7 0 0 0 0 0 0 0 7
TOTAL: 3 6101 176 0 2706 2 0 0 0 3217

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 101
it.tlc.cellulari.android 27
it.comp.os.win.windows10 14
comp.mobile.android 12
it.discussioni.energia 6
it.comp.os.linux.ubuntu 6
comp.mobile.ipad 3
de.comp.lang.vbclassic 2
it.comp.os.win.windows7 1
it.politica.m5s 1
alt.sex.telephones 1
alt.sex.eroticca.marketplace 1
it.comp.os.win.windows8 1
TOTAL: 13 176

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

GroupsCount
pl.sci.matematyka 1
bit.listserv.catholic 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1959
Binary in non-binary group 292
Scoring filter (8) 13
Scoring filter (9) 12
Scoring filter (10) 5
Scoring filter (16) 5
Too many newsgroups 2
Scoring filter (18) 1
TOTAL: 8 2289

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 618
news.nask.pl 285
TOTAL: 2 903
TOTAL: 1 903

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 39730 544 17581 61 1 37596 1%23:59:58
2poznan 14558 382 8831 33 0 0 2%23:59:58
3icm 20189 30 16735 12 0 0 0%23:59:44
4nask 5113 1 2436 2296 0 0 0%23:43:28
5okapi 0 0 0 0 0 1105 0%23:57:51
TOTAL: 5 79590 957 45583 2402 1 38701 1%119:40:59
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama8.3 MB545.9 KB8.9 MB0.1 KB/s15.0 KB23:59:58
2icm3.1 MB690.2 KB3.8 MB0.0 KB/s92.7 KB23:59:44
3poznan1.5 MB163.2 KB1.6 MB0.0 KB/s4.0 KB23:59:58
4nask1.9 KB846.2 MB846.2 MB10.1 KB/s377.3 KB23:43:28
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 512.9 MB847.6 MB860.5 MB2.0 KB/s262.3 KB119:40:59
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3838.2 KB 18 0 000:00:20
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:01
TOTAL: 2 294 3838.2 KB 18 6 044:07:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 678 3838.2 KB 18 6 000:00:26
TOTAL: 1 678 3838.2 KB 18 6 044:07:43

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.192.177 79.660 138.572 0.00044:07:16
web.man.lodz.pl 1.048 7.092 0.00000:00:20
mon.man.lodz.pl 0.980 6.960 0.00000:00:03
isvcs01.man.lodz.pl 0.032 0.164 0.00000:00:01
david.man.lodz.pl 0.356 2.332 0.00000:00:01
TOTAL: 5 82.076 155.120 0.00044:07:43

Curious NNRP server explorers [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1pl 38100.0%
TOTAL: 1 38100.0%

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

NewsgroupCount
1pl.comp.pecet 30
2pl.comp.os.ms-windows.winnt 8
TOTAL: 2 38