Daily Usenet report

May 16 04:15:01 -- May 17 04:15:01

Unknown entries from news log file:

First 38 / 38 lines (100.0%)

May 16 04:16:59 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
May 16 06:48:35 newsfeed overchan[909688]: input line too long, skipping
May 16 06:49:11 newsfeed overchan[909688]: input line too long, skipping
May 16 08:15:37 newsfeed nnrpd[920901]: SERVER perl filter not defined
May 16 10:08:59 newsfeed overchan[909688]: input line too long, skipping
May 16 11:58:59 newsfeed nnrpd[930729]: SERVER perl filter not defined
May 16 14:29:04 newsfeed nnrpd[950170]: SERVER perl filter not defined
May 16 14:31:52 newsfeed nnrpd[950294]: SERVER perl filter not defined
May 16 15:57:35 newsfeed overchan[909688]: input line too long, skipping
May 16 16:03:10 newsfeed overchan[909688]: input line too long, skipping
May 16 16:04:15 newsfeed overchan[909688]: input line too long, skipping
May 16 16:16:44 newsfeed overchan[909688]: input line too long, skipping
May 16 16:19:25 newsfeed overchan[909688]: input line too long, skipping
May 16 16:19:35 newsfeed overchan[909688]: input line too long, skipping
May 16 16:24:07 newsfeed overchan[909688]: input line too long, skipping
May 16 16:31:11 newsfeed overchan[909688]: input line too long, skipping
May 16 16:35:10 newsfeed overchan[909688]: input line too long, skipping
May 16 16:37:34 newsfeed overchan[909688]: input line too long, skipping
May 16 16:44:17 newsfeed overchan[909688]: input line too long, skipping
May 16 16:47:02 newsfeed overchan[909688]: input line too long, skipping
May 16 16:57:13 newsfeed overchan[909688]: input line too long, skipping
May 16 16:58:57 newsfeed overchan[909688]: input line too long, skipping
May 16 17:05:19 newsfeed overchan[909688]: input line too long, skipping
May 16 17:08:07 newsfeed overchan[909688]: input line too long, skipping
May 16 17:09:09 newsfeed overchan[909688]: input line too long, skipping
May 16 17:16:35 newsfeed overchan[909688]: input line too long, skipping
May 16 18:37:12 newsfeed overchan[909688]: input line too long, skipping
May 16 20:34:44 newsfeed overchan[909688]: input line too long, skipping
May 16 21:06:13 newsfeed overchan[909688]: input line too long, skipping
May 16 21:06:20 newsfeed nnrpd[968160]: SERVER perl filter not defined
May 16 21:13:40 newsfeed overchan[909688]: input line too long, skipping
May 16 21:26:17 newsfeed overchan[909688]: input line too long, skipping
May 16 21:32:57 newsfeed overchan[909688]: input line too long, skipping
May 16 21:40:18 newsfeed overchan[909688]: input line too long, skipping
May 16 21:56:33 newsfeed overchan[909688]: input line too long, skipping
May 16 22:33:19 newsfeed overchan[909688]: input line too long, skipping
May 16 22:50:10 newsfeed nnrpd[972812]: SERVER perl filter not defined
May 16 22:53:49 newsfeed overchan[909688]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 110455 76.7%12.5 MB 76.2%
innfeed 23759 16.5%2.8 MB 16.9%
nnrpd 7713 5.4%860.9 KB 5.1%
innd 2066 1.4%286.0 KB 1.7%
overchan 32 0.0%4.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 144026 100.0%16.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 109698 98.9%
Negative hits 1042 0.9%
Positive hits 199 0.2%
Cache misses 16 0.0%
TOTAL: 4 110955 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.377 0.0%27 0.000 13.963 35.000
article cleanup00:00:00.534 0.0%109752 0.000 0.005 0.014
article logging00:00:02.187 0.0%110003 0.005 0.020 0.049
article parse00:00:03.417 0.0%808044 0.002 0.004 0.009
article write00:00:13.764 0.0%109689 0.039 0.125 3.340
artlog/artcncl00:00:00.000 0.0%27 0.000 0.000 0.000
data move00:00:00.862 0.0%1087629 0.000 0.001 0.004
hisgrep/artcncl00:00:00.147 0.0%27 0.000 5.444 10.000
hishave/artcncl00:00:00.018 0.0%27 0.000 0.667 2.429
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:04:24.741 0.3%110980 0.711 2.385 14.876
history sync00:00:00.022 0.0%381 0.000 0.058 0.667
history write00:09:09.869 0.6%109750 1.910 5.010 14.389
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:34:40.584 98.9%897340 4.635 94.591 555.994
nntp read00:00:08.136 0.0%799578 0.006 0.010 0.026
overview write00:00:00.277 0.0%109689 0.000 0.003 0.012
perl filter00:01:47.366 0.1%109750 0.515 0.978 1.606
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.631 0.0%227345 0.004 0.012 0.027
TOTAL: 23:51:01.39723:50:34.932100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.031 0.0%28276 0.000 0.001 0.012
article prepare00:00:00.002 0.0%3230 0.000 0.001 0.062
article read00:00:13.336 0.0%825 0.000 16.165 109.500
backlog stats00:00:00.031 0.0%65052 0.000 0.000 0.006
callbacks00:00:00.000 0.0%23 0.000 0.000 0.000
data read00:00:00.255 0.0%31375 0.000 0.008 0.035
data write00:00:00.598 0.0%23506 0.000 0.025 0.089
idle23:55:37.362100.0%65052 449.512 1324.131 3558.754
status file00:00:10.116 0.0%7741 0.184 1.307 53.342
TOTAL: 23:56:03.69323:56:01.731100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:09.365 79.1%4255 0.000 16.302 14408.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.123 0.1%10334 0.000 0.012 0.500
readart00:00:00.092 0.1%28 0.000 3.286 7.583
TOTAL: 00:01:27.67200:01:09.580 79.4%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 191

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 74 110248 110186 3 59 99%39:15:20
2localhost 7 6 6 0 0 100%00:00:00
3news.icm.edu.pl 46 196 5 187 4 2%15:07:24
TOTAL: 3 127 110450 110197 190 63 99%54:22:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.9 GB27.1 KB182.2 KB1.9 GB 99%18.0 KB
2news.icm.edu.pl254.6 KB0.0 KB57.9 KB312.5 KB 81%34.7 KB
3localhost9.0 KB0.0 KB0.0 KB9.0 KB100%1.5 KB
TOTAL: 31.9 GB27.1 KB240.1 KB1.9 GB 99%18.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 16 04:15:01 - 04:59:59 8800 8.0% 3.26132.9 MB 6.8% 50.42
May 16 05:00:00 - 05:59:59 6308 5.7% 1.75125.0 MB 6.4% 35.54
May 16 06:00:00 - 06:59:59 4108 3.7% 1.1467.4 MB 3.5% 19.18
May 16 07:00:00 - 07:59:59 4240 3.9% 1.1865.9 MB 3.4% 18.73
May 16 08:00:00 - 08:59:59 7275 6.6% 2.02111.6 MB 5.8% 31.76
May 16 09:00:00 - 09:59:59 14023 12.7% 3.90427.3 MB 22.0% 121.54
May 16 10:00:00 - 10:59:59 4847 4.4% 1.3581.2 MB 4.2% 23.11
May 16 11:00:00 - 11:59:59 2483 2.3% 0.6940.8 MB 2.1% 11.61
May 16 12:00:00 - 12:59:59 2496 2.3% 0.6941.5 MB 2.1% 11.80
May 16 13:00:00 - 13:59:59 9280 8.4% 2.5862.0 MB 3.2% 17.63
May 16 14:00:00 - 14:59:59 3037 2.8% 0.8449.7 MB 2.6% 14.12
May 16 15:00:00 - 15:59:59 3270 3.0% 0.9158.5 MB 3.0% 16.64
May 16 16:00:00 - 16:59:59 4113 3.7% 1.1467.1 MB 3.5% 19.08
May 16 17:00:00 - 17:59:59 2834 2.6% 0.7947.4 MB 2.4% 13.49
May 16 18:00:00 - 18:59:59 4386 4.0% 1.22166.3 MB 8.6% 47.30
May 16 19:00:00 - 19:59:59 3119 2.8% 0.8753.1 MB 2.7% 15.10
May 16 20:00:00 - 20:59:59 3155 2.9% 0.8854.3 MB 2.8% 15.44
May 16 21:00:00 - 21:59:59 2861 2.6% 0.7944.7 MB 2.3% 12.72
May 16 22:00:00 - 22:59:59 3089 2.8% 0.8638.2 MB 2.0% 10.87
May 16 23:00:00 - 23:59:59 4901 4.5% 1.3643.9 MB 2.3% 12.48
May 17 00:00:00 - 00:59:59 3875 3.5% 1.0851.8 MB 2.7% 14.74
May 17 01:00:00 - 01:59:59 3127 2.8% 0.8745.1 MB 2.3% 12.82
May 17 02:00:00 - 02:59:59 2203 2.0% 0.6129.3 MB 1.5% 8.34
May 17 03:00:00 - 03:59:59 1568 1.4% 0.4424.7 MB 1.3% 7.03
May 17 04:00:00 - 04:15:01 714 0.6% 0.7911.2 MB 0.6% 12.76
TOTAL: 24:00:00 110112 100.0% 1.271.9 GB 100.0% 23.00
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 312 56 0 2 1 0 0 0 253
2news.icm.edu.pl 4 0 0 0 0 0 0 0 4
TOTAL: 2 316 56 0 2 1 0 0 0 257

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 31
comp.mobile.android 11
de.comp.office-pakete.ms-office.word 4
alt.comp.software.seamonkey 4
it.comp.os.win.windows10 3
it.tlc.cellulari.android 2
alt.comp.software.firefox 1
TOTAL: 7 56

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

GroupsCount
soc.culture.jewish.holocaust 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 4
TOTAL: 1 4

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 20607 190 7515 180 41 20383 0%23:57:48
2icm 11268 43 7829 9 0 0 0%23:59:59
3nask 0 0 0 0 0 6250 0%23:57:48
4okapi 0 0 0 0 0 698 0%23:57:48
5poznan 8 0 5 0 0 0 0%00:45:18
TOTAL: 5 31883 233 15349 189 41 27331 0%96:38:41
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.7 MB1.6 MB3.3 MB0.0 KB/s9.2 KB23:57:48
2icm125.6 KB73.1 KB198.7 KB0.0 KB/s3.8 KB23:59:59
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:45:18
TOTAL: 51.9 MB1.6 MB3.5 MB0.0 KB/s8.5 KB96:38:41
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 287 129.3 KB 6 0 000:00:09
246.219.209.156 2 1217.5 KB 2 0 000:00:03
3isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 3 295 2426.8 KB 8 6 000:01:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1733 129.3 KB 6 6 000:00:22
2unresolved 111 1217.5 KB 2 0 000:00:18
3*.warszawa.vectranet.pl 1 00.0 KB 0 0 000:00:43
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 51847 2426.8 KB 8 6 000:01:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
077222239194.warszawa.vectranet.pl 0.007 0.014 0.00000:00:43
nms2.man.lodz.pl 2.779 10.015 0.00000:00:13
192.241.203.5 0.003 0.010 0.00000:00:09
web.man.lodz.pl 0.603 2.224 0.00000:00:09
46.219.209.156 0.025 0.024 0.00000:00:03
luminous.monitoring.internet-measurement.com 0.001 0.007 0.00000:00:02
80.111.142.213 0.004 0.031 0.00000:00:01
106.75.164.148 0.015 0.024 0.00000:00:01
212.51.192.185 0.185 0.684 0.00000:00:00
194.165.16.76 0.004 0.004 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.005 0.005 0.00000:00:00
192.241.200.31 0.006 0.006 0.00000:00:00
isvcs01.man.lodz.pl 0.024 0.057 0.00000:00:00
147.78.47.60 0.005 0.003 0.00000:00:00
45.227.254.48 0.000 0.010 0.00000:00:00
TOTAL: 15 3.666 13.118 0.00000:01:28

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 95
106.75.164.148 5
80.111.142.213 4
192.241.203.5 1
luminous.monitoring.internet-measurement.com 1
077222239194.warszawa.vectranet.pl 1
45.227.254.48 1
147.78.47.60 1
scanner-26.ch1.censys-scanner.com 1
194.165.16.76 1
192.241.200.31 1
TOTAL: 12 1552

NNRP unrecognized commands (by host):

SystemConn
106.75.164.148 1
scanner-26.ch1.censys-scanner.com 1
194.165.16.76 1
45.227.254.48 1
147.78.47.60 1
192.241.200.31 1
TOTAL: 6 6

NNRP unrecognized commands (by command):

CommandCount
#003 3
žaQ[Q"?;#0077#006(3V4#030#004,WR#0158S#0172#0100X1#0269#024#022$U"#020 1
MGLNDD_212.191.2.21_119 1
EHLO www.censys.io 1
TOTAL: 4 6

NNRP client timeouts [Top 20]:

SystemConnPeer
147.78.47.60 1 1
45.227.254.48 1 1
194.165.16.76 1 1
TOTAL: 3 3 3

Newsgroup request counts (by category):

CategoryCountPct
1lodman 12 50.0%
2pl 12 50.0%
TOTAL: 2 24100.0%

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

NewsgroupCount
1lodman.info 12
2pl.comp.os.ms-windows.winnt 8
3pl.comp.pecet 4
TOTAL: 3 24