Daily Usenet report

Jan 22 04:15:02 -- Jan 23 04:15:03

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Jan 22 09:31:55 newsfeed overchan[2199]: input line too long, skipping
Jan 22 10:03:39 newsfeed nnrpd[15397]: SERVER perl filter not defined
Jan 22 10:26:30 newsfeed nnrpd[16700]: SERVER perl filter not defined
Jan 22 10:45:42 newsfeed overchan[2199]: input line too long, skipping
Jan 22 11:05:57 newsfeed overchan[2199]: input line too long, skipping
Jan 22 11:27:15 newsfeed nnrpd[19037]: SERVER perl filter not defined
Jan 22 16:11:05 newsfeed overchan[2199]: input line too long, skipping
Jan 22 16:28:29 newsfeed overchan[2199]: input line too long, skipping
Jan 22 16:39:22 newsfeed overchan[2199]: input line too long, skipping
Jan 22 16:46:03 newsfeed nnrpd[30643]: SERVER perl filter not defined
Jan 22 19:47:04 newsfeed overchan[2199]: input line too long, skipping
Jan 22 21:04:45 newsfeed overchan[2199]: input line too long, skipping
Jan 22 21:07:22 newsfeed overchan[2199]: input line too long, skipping
Jan 22 21:18:52 newsfeed overchan[2199]: input line too long, skipping
Jan 22 21:20:36 newsfeed overchan[2199]: input line too long, skipping
Jan 22 21:21:20 newsfeed overchan[2199]: input line too long, skipping
Jan 22 21:24:09 newsfeed overchan[2199]: input line too long, skipping
Jan 22 22:58:50 newsfeed overchan[2199]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn3660877 98.0%419.6 MB 97.8%
innfeed 40958 1.1%4.8 MB 1.1%
innd 26632 0.7%4.3 MB 1.0%
nnrpd 5510 0.1%593.3 KB 0.1%
overchan 15 0.0%2.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 63733993 100.0%429.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3602598 96.9%
Negative hits 102624 2.8%
Positive hits 11685 0.3%
Cache misses 430 0.0%
TOTAL: 4 3717337 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.122 0.0%67 0.000 31.672 326.000
article cleanup00:00:38.970 0.0%3630114 0.008 0.011 0.015
article logging00:02:25.194 0.2%3630752 0.028 0.040 0.094
article parse00:51:51.845 3.6%86555300 0.016 0.036 0.062
article write00:22:22.497 1.6%3621890 0.211 0.371 1.514
artlog/artcncl00:00:00.001 0.0%66 0.000 0.015 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:42.143 0.2%102916492 0.001 0.002 0.003
hisgrep/artcncl00:00:00.242 0.0%67 0.000 3.612 19.500
hishave/artcncl00:00:00.025 0.0%67 0.000 0.373 1.889
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:48:19.645 7.6%3746419 0.279 1.735 7.290
history sync00:00:00.018 0.0%294 0.000 0.061 0.500
history write05:40:43.819 23.8%3628398 1.525 5.634 13.042
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle07:33:49.580 31.7%52313582 0.086 0.521 1.099
nntp read00:52:40.205 3.7%83538818 0.024 0.038 0.053
overview write00:00:18.248 0.0%3621890 0.003 0.005 0.007
perl filter06:03:26.229 25.4%3628398 4.114 6.010 7.579
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:06:45.923 0.5%7267458 0.032 0.056 0.072
TOTAL: 23:50:12.09523:26:06.706 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.182 0.0%60917 0.000 0.003 0.016
article prepare00:00:00.011 0.0%22162 0.000 0.000 0.017
article read00:01:54.781 0.1%5515 0.452 20.813 281.800
backlog stats00:00:00.162 0.0%171568 0.000 0.001 0.005
callbacks00:00:00.000 0.0%13 0.000 0.000 0.000
data read00:00:01.731 0.0%94857 0.007 0.018 0.056
data write00:00:05.616 0.0%72254 0.028 0.078 0.338
idle23:51:09.905 99.8%171568 64.521 500.501 1134.331
status file00:00:28.314 0.0%15304 0.650 1.850 24.710
TOTAL: 23:53:57.56623:53:40.702100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:13:19.531 98.0%6351 0.000 125.891 21648.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.449 0.1%13418 0.000 0.033 2.667
readart00:00:00.033 0.0%40 0.000 0.825 14.500
TOTAL: 00:13:35.77800:13:20.013 98.1%----

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 336 36535333641239 9352 2942 99%537:52:46
2news.nask.pl 3 16910 10765 872 5273 63%23:42:17
3news.icm.edu.pl 44 290 34 235 21 11%17:57:24
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 388 36707373652042 10459 8236 99%579:32:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl777.3 GB86.9 MB273.6 MB777.6 GB 99%223.8 KB
2news.nask.pl42.0 MB1.2 MB103.1 MB146.4 MB 28%9.3 KB
3news.icm.edu.pl960.5 KB0.0 KB1.1 MB2.0 MB 46%37.3 KB
4localhost11.0 KB0.0 KB0.0 KB11.0 KB100%2.7 KB
TOTAL: 4777.3 GB88.1 MB377.8 MB777.8 GB 99%222.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 22 04:15:02 - 04:59:59 96079 2.6% 35.6122.1 GB 2.8%8593.71
Jan 22 05:00:00 - 05:59:59 147395 4.0% 40.9433.7 GB 4.3%9823.45
Jan 22 06:00:00 - 06:59:59 139026 3.8% 38.6233.4 GB 4.3%9714.41
Jan 22 07:00:00 - 07:59:59 108256 3.0% 30.0724.5 GB 3.2%7131.55
Jan 22 08:00:00 - 08:59:59 130497 3.6% 36.2531.8 GB 4.1%9258.85
Jan 22 09:00:00 - 09:59:59 114647 3.1% 31.8522.9 GB 2.9%6659.55
Jan 22 10:00:00 - 10:59:59 122681 3.4% 34.0824.8 GB 3.2%7224.20
Jan 22 11:00:00 - 11:59:59 141496 3.9% 39.3028.8 GB 3.7%8382.09
Jan 22 12:00:00 - 12:59:59 156429 4.3% 43.4537.0 GB 4.8%10788.62
Jan 22 13:00:00 - 13:59:59 164849 4.5% 45.7938.0 GB 4.9%11078.78
Jan 22 14:00:00 - 14:59:59 177891 4.9% 49.4137.8 GB 4.9%11001.80
Jan 22 15:00:00 - 15:59:59 197657 5.4% 54.9038.8 GB 5.0%11293.15
Jan 22 16:00:00 - 16:59:59 202772 5.6% 56.3339.7 GB 5.1%11550.73
Jan 22 17:00:00 - 17:59:59 175989 4.8% 48.8939.1 GB 5.0%11400.06
Jan 22 18:00:00 - 18:59:59 171650 4.7% 47.6839.4 GB 5.1%11464.38
Jan 22 19:00:00 - 19:59:59 164311 4.5% 45.6434.0 GB 4.4%9893.62
Jan 22 20:00:00 - 20:59:59 135872 3.7% 37.7425.7 GB 3.3%7475.00
Jan 22 21:00:00 - 21:59:59 152256 4.2% 42.2929.2 GB 3.8%8508.53
Jan 22 22:00:00 - 22:59:59 187364 5.1% 52.0534.2 GB 4.4%9961.78
Jan 22 23:00:00 - 23:59:59 140567 3.8% 39.0527.1 GB 3.5%7880.67
Jan 23 00:00:00 - 00:59:59 145047 4.0% 40.2929.3 GB 3.8%8536.97
Jan 23 01:00:00 - 01:59:59 165129 4.5% 45.8733.3 GB 4.3%9690.46
Jan 23 02:00:00 - 02:59:59 141697 3.9% 39.3632.3 GB 4.2%9409.98
Jan 23 03:00:00 - 03:59:59 133040 3.6% 36.9632.1 GB 4.1%9361.08
Jan 23 04:00:00 - 04:15:03 39343 1.1% 43.578.4 GB 1.1%9797.40
TOTAL: 24:00:01 3651940 100.0% 42.27777.2 GB 100.0%9432.71
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 5589 41 0 151 6 0 0 0 5391
2newsfeed.pionier.net.pl 3261 174 0 1573 1 0 0 0 1513
3news.icm.edu.pl 21 0 0 0 0 0 0 0 21
TOTAL: 3 8871 215 0 1724 7 0 0 0 6925

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 91
comp.sys.raspberry-pi 42
it.comp.os.win.windows10 28
it.tlc.cellulari.android 25
comp.mobile.android 7
de.rec.sf.startrek 5
hr.ponuda.hardver.komponente 4
comp.mobile.ipad 4
it.comp.os.win.windows7 3
it.politica.m5s 2
it.tlc.cellulari.iphone 2
de.comp.office-pakete.ms-office.word 1
it.comp.os.linux.ubuntu 1
TOTAL: 13 215

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4435
Binary in non-binary group 1775
Scoring filter (9) 39
Scoring filter (8) 17
Scoring filter (18) 7
Scoring filter (10) 6
HTML post 4
Scoring filter (11) 2
Scoring filter (12) 1
TOTAL: 9 6286

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nask.pl 320
newsfeed.pionier.net.pl 319
TOTAL: 2 639
TOTAL: 1 639

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 25610 2349 19950 171 0 0 9%23:59:58
2panorama 45036 1079 18177 312 33 41402 2%23:59:58
3poznan 16554 768 10070 32 0 1 4%23:59:42
4nask 3128 4 2766 0 0 0 0%23:59:58
5okapi 0 0 0 0 0 1298 0%23:57:51
TOTAL: 5 90328 4200 50963 515 33 42701 4%119:57:27
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm427.1 MB441.8 KB427.5 MB5.1 KB/s173.7 KB23:59:58
2panorama5.7 MB1.2 MB6.9 MB0.1 KB/s5.1 KB23:59:58
3poznan2.7 MB161.7 KB2.9 MB0.0 KB/s3.7 KB23:59:42
4nask8.0 KB0.0 KB8.0 KB0.0 KB/s2.0 KB23:59:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 5435.5 MB1.7 MB437.3 MB1.0 KB/s95.0 KB119:57:27
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3844.3 KB 19 0 000:00:45
2212.51.203.199 2 23.3 KB 1 0 000:02:26
3isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 3 294 4047.6 KB 20 4 000:13:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 676 3844.3 KB 19 4 000:00:51
2unresolved 4 23.3 KB 1 0 000:12:15
3*.dynamic.gprs.plus.pl 2 00.0 KB 0 0 000:00:08
4*.088.071.pools.vodafone-ip.de 176 00.0 KB 0 0 000:00:19
TOTAL: 4 858 4047.6 KB 20 4 000:13:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.195.97 0.196 0.272 0.00000:09:39
212.51.203.199 0.016 0.048 0.00000:02:26
web.man.lodz.pl 1.648 7.248 0.00000:00:45
dslb-088-071-150-185.088.071.pools.vodafone-ip.de 0.804 3.228 0.00000:00:19
107.170.230.198 0.004 0.036 0.00000:00:09
apn-31-0-39-33.dynamic.gprs.plus.pl 0.004 0.028 0.00000:00:08
mon.man.lodz.pl 1.368 6.668 0.00000:00:03
david.man.lodz.pl 0.436 2.264 0.00000:00:01
isvcs01.man.lodz.pl 0.040 0.124 0.00000:00:00
TOTAL: 9 4.516 19.916 0.00000:13:34

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
dslb-088-071-150-185.088.071.pools.vodafone-ip.de 176
david.man.lodz.pl 96
apn-31-0-39-33.dynamic.gprs.plus.pl 2
185.48.195.97 1
107.170.230.198 1
TOTAL: 6 564

Newsgroup request counts (by category):

CategoryCountPct
1pl 40100.0%
TOTAL: 1 40100.0%

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

NewsgroupCount
1pl.comp.pecet 28
2pl.comp.os.ms-windows.winnt 10
3pl.rec.radio.amatorskie 2
TOTAL: 3 40