Daily Usenet report

Sep 12 04:15:02 -- Sep 15 04:15:02

Unknown entries from news log file:

First 50 / 470 lines (10.6%)

Sep 12 04:21:00 newsfeed nnrpd[428546]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:22:01 newsfeed nnrpd[428555]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:23:00 newsfeed nnrpd[428564]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:24:01 newsfeed nnrpd[428573]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:25:00 newsfeed nnrpd[428594]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:25:02 newsfeed nnrpd[428668]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:25:02 newsfeed nnrpd[428669]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:25:02 newsfeed nnrpd[428671]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:25:02 newsfeed nnrpd[428672]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:25:02 newsfeed nnrpd[428673]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:25:02 newsfeed nnrpd[428675]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:25:02 newsfeed nnrpd[428676]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:26:00 newsfeed nnrpd[428696]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:26:47 newsfeed nnrpd[428705]: 212.51.192.185 rejected Expiring process 428365
Sep 12 04:27:00 newsfeed nnrpd[428707]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:28:00 newsfeed nnrpd[428717]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:29:02 newsfeed nnrpd[428872]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:30:00 newsfeed nnrpd[428893]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:30:03 newsfeed nnrpd[428894]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:30:05 newsfeed nnrpd[428895]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:30:05 newsfeed nnrpd[428896]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:30:05 newsfeed nnrpd[428897]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:30:05 newsfeed nnrpd[428898]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:30:05 newsfeed nnrpd[428899]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:30:05 newsfeed nnrpd[428900]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:31:00 newsfeed nnrpd[428992]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:32:00 newsfeed nnrpd[429002]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:33:00 newsfeed nnrpd[429011]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:34:00 newsfeed nnrpd[429021]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:35:00 newsfeed nnrpd[429047]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:35:01 newsfeed nnrpd[429120]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:35:01 newsfeed nnrpd[429122]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:35:01 newsfeed nnrpd[429123]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:35:02 newsfeed nnrpd[429124]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:35:02 newsfeed nnrpd[429125]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:35:02 newsfeed nnrpd[429126]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:35:02 newsfeed nnrpd[429127]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:36:00 newsfeed nnrpd[429145]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:37:00 newsfeed nnrpd[429155]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:38:00 newsfeed nnrpd[429167]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:39:00 newsfeed nnrpd[429291]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:40:00 newsfeed nnrpd[429358]: nms2.man.lodz.pl rejected Expiring process 428365
Sep 12 04:40:01 newsfeed nnrpd[429429]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:40:01 newsfeed nnrpd[429430]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:40:02 newsfeed nnrpd[429432]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:40:02 newsfeed nnrpd[429434]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:40:02 newsfeed nnrpd[429435]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:40:02 newsfeed nnrpd[429436]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:40:02 newsfeed nnrpd[429438]: web.man.lodz.pl rejected Expiring process 428365
Sep 12 04:41:00 newsfeed nnrpd[429456]: nms2.man.lodz.pl rejected Expiring process 428365

Log entries by program:

Program nameLines%LinesSize%Size
inn 99356 89.4%11.2 MB 90.6%
nnrpd 7969 7.2%789.5 KB 6.2%
innd 2386 2.1%273.7 KB 2.2%
innfeed 1353 1.2%131.5 KB 1.0%
overchan 23 0.0%2.3 KB 0.0%
controlchan 13 0.0%2.7 KB 0.0%
rnews 2 0.0%0.1 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 111103 100.0%12.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 98792 96.5%
Negative hits 2745 2.7%
Positive hits 842 0.8%
Cache misses 17 0.0%
TOTAL: 4 102396 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.292 0.0%37 0.000 7.892 56.000
article cleanup00:00:00.574 0.0%99686 0.000 0.006 0.016
article logging00:00:02.293 0.0%99688 0.009 0.023 0.043
article parse00:00:02.884 0.0%479558 0.002 0.006 0.014
article write00:00:19.597 0.0%98841 0.052 0.198 0.970
artlog/artcncl00:00:00.000 0.0%37 0.000 0.000 0.000
data move00:00:00.593 0.0%931782 0.000 0.001 0.003
hisgrep/artcncl00:00:00.070 0.0%37 0.000 1.892 11.000
hishave/artcncl00:00:00.003 0.0%37 0.000 0.081 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:06:07.156 0.5%103418 1.498 3.550 5.598
history sync00:00:00.013 0.0%295 0.000 0.044 0.500
history write00:06:43.011 0.5%99655 1.921 4.044 17.894
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:05:19.282 98.8%856383 22.702 92.855 20690.621
nntp read00:00:08.400 0.0%764949 0.004 0.011 0.035
overview write00:00:00.298 0.0%98841 0.000 0.003 0.010
perl filter00:01:29.734 0.1%99655 0.660 0.900 1.420
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.769 0.0%210889 0.005 0.013 0.024
TOTAL: 22:20:47.15322:20:16.969100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%13170 0.000 0.002 0.014
article prepare00:00:00.000 0.0%104 0.000 0.000 0.000
article read00:00:00.001 0.0%26 0.000 0.038 0.333
backlog stats00:00:00.026 0.0%53657 0.000 0.000 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.265 0.0%29001 0.000 0.009 0.032
data write00:00:00.603 0.0%15985 0.000 0.038 0.087
idle22:17:56.947100.0%53657 203.588 1496.113 20054.433
status file00:00:00.425 0.0%379 0.000 1.121 9.429
TOTAL: 22:17:59.17722:17:58.293100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:09.866 37.3%3383 0.000 2.916 1163.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.108 0.4%8636 0.000 0.013 1.000
readart00:00:00.001 0.0%10 0.000 0.100 0.500
TOTAL: 00:00:26.45400:00:09.975 37.7%----

Control commands to INND:

CommandNumber
flush 26
flushlogs 2
go 1
logmode 2
lowmark 1
mode 141
name 2
pause 2
paused 2
reload 2
reserve 1
throttle 18
TOTAL: 12 200

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newgroups-request@fido7.ru001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 73 96547 96380 5 162 99%34:03:10
2news.icm.edu.pl 10 3419 1941 795 683 56%18:46:47
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 84 99966 98321 800 845 98%52:49:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.0 GB452.9 KB1.3 MB1.0 GB 99%11.3 KB
2news.icm.edu.pl52.6 MB273.1 KB13.0 MB65.9 MB 79%25.7 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 31.1 GB725.9 KB14.3 MB1.1 GB 98%11.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 12 04:15:02 - 04:59:59 407 0.4% 0.156.9 MB 0.0% 2.61
Sep 12 05:00:00 - 05:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 06:00:00 - 06:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 07:00:00 - 07:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 08:00:00 - 08:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 09:00:00 - 09:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 10:00:00 - 10:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 11:00:00 - 11:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 12:00:00 - 12:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 13:00:00 - 13:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 14:00:00 - 14:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 15:00:00 - 15:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 16:00:00 - 16:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 17:00:00 - 17:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 18:00:00 - 18:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 19:00:00 - 19:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 20:00:00 - 20:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 21:00:00 - 21:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 22:00:00 - 22:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 12 23:00:00 - 23:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 00:00:00 - 00:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 01:00:00 - 01:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 02:00:00 - 02:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 03:00:00 - 03:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 04:00:00 - 04:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 05:00:00 - 05:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 06:00:00 - 06:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 07:00:00 - 07:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 08:00:00 - 08:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 14 09:00:00 - 09:59:59 5985 6.1% 1.6692.4 MB 0.0% 26.27
Sep 14 10:00:00 - 10:59:59 5616 5.7% 1.5654.5 MB 0.0% 15.51
Sep 14 11:00:00 - 11:59:59 4536 4.6% 1.2653.0 MB 0.0% 15.08
Sep 14 12:00:00 - 12:59:59 3234 3.3% 0.9036.3 MB 0.0% 10.31
Sep 14 13:00:00 - 13:59:59 5503 5.6% 1.53160.5 MB 0.0% 45.65
Sep 14 14:00:00 - 14:59:59 5628 5.7% 1.5645.8 MB 0.0% 13.02
Sep 14 15:00:00 - 15:59:59 5947 6.0% 1.6554.3 MB 0.0% 15.43
Sep 14 16:00:00 - 16:59:59 6968 7.1% 1.9483.1 MB 0.0% 23.65
Sep 14 17:00:00 - 17:59:59 7438 7.6% 2.0770.3 MB 0.0% 20.00
Sep 14 18:00:00 - 18:59:59 7731 7.9% 2.1567.5 MB 0.0% 19.19
Sep 14 19:00:00 - 19:59:59 5743 5.8% 1.6051.4 MB 0.0% 14.63
Sep 14 20:00:00 - 20:59:59 4705 4.8% 1.3152.8 MB 0.0% 15.02
Sep 14 21:00:00 - 21:59:59 4719 4.8% 1.3146.9 MB 0.0% 13.33
Sep 14 22:00:00 - 22:59:59 4111 4.2% 1.1446.3 MB 0.0% 13.17
Sep 14 23:00:00 - 23:59:59 3825 3.9% 1.0638.5 MB 0.0% 10.96
Sep 15 00:00:00 - 00:59:59 3887 3.9% 1.0843.9 MB 0.0% 12.50
Sep 15 01:00:00 - 01:59:59 4207 4.3% 1.1744.9 MB 0.0% 12.78
Sep 15 02:00:00 - 02:59:59 4146 4.2% 1.1532.8 MB 0.0% 9.33
Sep 15 03:00:00 - 03:59:59 3413 3.5% 0.9530.9 MB 0.0% 8.78
Sep 15 04:00:00 - 04:15:02 723 0.7% 0.806.5 MB 0.0% 7.41
TOTAL: 48:00:00 98472 100.0% 0.570.0 KB 100.0% 0.00
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 683 3 0 11 0 0 0 0 669
2newsfeed.pionier.net.pl 164 126 0 20 0 0 0 0 18
TOTAL: 2 847 129 0 31 0 0 0 0 687

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 84
it.comp.os.win.windows10 16
it.tlc.cellulari.android 13
comp.mobile.android 8
comp.mobile.ipad 4
comp.sys.raspberry-pi 1
alt.comp.software.firefox 1
de.comp.lang.vbclassic 1
alt.comp.software.seamonkey 1
TOTAL: 9 129

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 365
Scoring filter (8) 234
EMP (md5) 53
Scoring filter (9) 22
Scoring filter (10) 8
Scoring filter (12) 1
Scoring filter (13) 1
Scoring filter (11) 1
TOTAL: 8 685

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 2
TOTAL: 1 2
TOTAL: 1 2

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15520 18 10791 8 0 0 0%19:46:03
2okapi 0 0 0 0 0 637 0%22:30:51
3nask 0 0 0 0 0 9592 0%22:40:51
4poznan 417 0 402 0 0 0 0%04:04:07
5panorama 0 0 0 0 0 13228 0%22:40:51
TOTAL: 5 15937 18 11193 8 0 23457 0%91:42:43
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm64.8 KB18.9 KB83.7 KB0.0 KB/s3.2 KB19:46:03
2okapi0.0 KB0.0 KB0.0 KB0.0 KB/s022:30:51
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s022:40:51
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s004:04:07
5panorama0.0 KB0.0 KB0.0 KB0.0 KB/s022:40:51
TOTAL: 564.8 KB18.9 KB83.7 KB0.0 KB/s3.2 KB91:42:43
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.7 KB
TOTAL: 1976.7 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 480 109.8 KB 5 0 000:00:08
TOTAL: 1 480 109.8 KB 5 0 000:00:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1829 109.8 KB 5 0 000:00:20
2unresolved 99 00.0 KB 0 0 000:00:05
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 31929 109.8 KB 5 0 000:00:26

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 3.722 6.667 0.00000:00:12
web.man.lodz.pl 1.174 3.056 0.00000:00:08
80.111.142.213 0.017 0.025 0.00000:00:02
208.100.26.232 0.007 0.010 0.00000:00:01
212.51.192.185 0.246 0.492 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.006 0.003 0.00000:00:00
192.241.233.38 0.003 0.003 0.00000:00:00
198.199.107.71 0.000 0.010 0.00000:00:00
162.243.136.35 0.004 0.004 0.00000:00:00
TOTAL: 9 5.179 10.270 0.00000:00:26

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1349
212.51.192.185 90
80.111.142.213 4
208.100.26.232 2
192.241.233.38 1
scanner-26.ch1.censys-scanner.com 1
198.199.107.71 1
162.243.136.35 1
TOTAL: 8 1449

NNRP unrecognized commands (by host):

SystemConn
scanner-26.ch1.censys-scanner.com 1
192.241.233.38 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_212.191.2.21_119 1
EHLO www.censys.io 1
TOTAL: 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 10100.0%
TOTAL: 1 10100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 6
2pl.comp.pecet 4
TOTAL: 2 10