Daily Usenet report

Jun 7 04:15:01 -- Jun 9 04:15:01

Unknown entries from news log file:

First 50 / 5324 lines (0.9%)

Jun 7 06:38:53 newsfeed overchan[116922]: input line too long, skipping
Jun 7 09:23:29 newsfeed overchan[116922]: input line too long, skipping
Jun 7 09:26:13 newsfeed overchan[116922]: input line too long, skipping
Jun 7 10:15:02 newsfeed overchan[116922]: input line too long, skipping
Jun 7 10:57:56 newsfeed nnrpd[140756]: message repeated 2 times: [ 194.28.48.108 group lodz.ogolne 0]
Jun 7 14:56:04 newsfeed overchan[116922]: input line too long, skipping
Jun 7 15:16:21 newsfeed overchan[116922]: input line too long, skipping
Jun 7 15:33:14 newsfeed overchan[116922]: input line too long, skipping
Jun 7 15:53:00 newsfeed overchan[116922]: input line too long, skipping
Jun 7 16:33:04 newsfeed overchan[116922]: input line too long, skipping
Jun 7 16:35:47 newsfeed overchan[116922]: input line too long, skipping
Jun 7 18:26:47 newsfeed nnrpd[166443]: SERVER perl filter not defined
Jun 8 00:15:02 newsfeed pgpverify[189184]: pgpverify: /usr/bin/gpg1: no such file
Jun 8 00:15:02 newsfeed pgpverify[189198]: pgpverify: /usr/bin/gpg1: no such file
Jun 8 11:18:45 newsfeed overchan[1429]: input line too long, skipping
Jun 8 11:18:46 newsfeed overchan[1429]: input line too long, skipping
Jun 8 13:00:00 newsfeed overchan[1429]: input line too long, skipping
Jun 8 15:11:17 newsfeed nnrpd[16112]: SERVER perl filter not defined
Jun 8 15:13:38 newsfeed nnrpd[16129]: SERVER perl filter not defined
Jun 8 19:19:27 newsfeed overchan[1429]: input line too long, skipping
Jun 8 19:36:29 newsfeed nnrpd[1435]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:36:29 newsfeed nnrpd[1434]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:36:29 newsfeed nnrpd[1432]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:36:29 newsfeed nnrpd[1433]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:36:29 newsfeed nnrpd[1431]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:36:58 newsfeed nnrpd[1454]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:36:58 newsfeed nnrpd[1453]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:01 newsfeed nnrpd[1455]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:01 newsfeed nnrpd[1456]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:01 newsfeed nnrpd[1457]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:28 newsfeed nnrpd[1611]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:28 newsfeed nnrpd[1610]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:31 newsfeed nnrpd[1613]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:31 newsfeed nnrpd[1614]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:31 newsfeed nnrpd[1612]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:58 newsfeed nnrpd[1624]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:37:58 newsfeed nnrpd[1625]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:01 newsfeed nnrpd[1626]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:01 newsfeed nnrpd[1628]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:01 newsfeed nnrpd[1627]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:29 newsfeed nnrpd[1632]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:29 newsfeed nnrpd[1631]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:31 newsfeed nnrpd[1634]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:31 newsfeed nnrpd[1633]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:31 newsfeed nnrpd[1635]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:59 newsfeed nnrpd[1643]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:38:59 newsfeed nnrpd[1642]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:39:02 newsfeed nnrpd[1644]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:39:02 newsfeed nnrpd[1646]: newsfeed.pionier.net.pl noperm ihave without permission
Jun 8 19:39:02 newsfeed nnrpd[1645]: newsfeed.pionier.net.pl noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn1100541 92.8%123.7 MB 92.6%
innfeed 43968 3.7%5.1 MB 3.8%
nnrpd 26584 2.2%2.6 MB 2.0%
innd 14809 1.2%2.2 MB 1.6%
overchan 15 0.0%2.4 KB 0.0%
controlchan 6 0.0%0.4 KB 0.0%
pgpverify 2 0.0%0.2 KB 0.0%
TOTAL: 71185925 100.0%133.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1083302 99.4%
Negative hits 6007 0.6%
Positive hits 298 0.0%
Cache misses 25 0.0%
TOTAL: 4 1089632 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.259 0.0%70 0.000 17.986 134.000
article cleanup00:00:06.386 0.0%1085379 0.000 0.006 0.009
article logging00:00:22.193 0.0%1085975 0.000 0.020 0.026
article parse00:10:31.908 0.5%187093404 0.000 0.003 0.004
article write00:07:27.529 0.3%1085227 0.187 0.412 1.000
artlog/artcncl00:00:00.001 0.0%70 0.000 0.014 0.500
data move00:00:59.356 0.0%195020544 0.000 0.000 0.001
hisgrep/artcncl00:00:00.180 0.0%68 0.000 2.647 32.000
hishave/artcncl00:00:00.011 0.0%70 0.000 0.157 3.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:24:04.529 1.0%1092238 0.000 1.323 15.524
history sync00:00:00.010 0.0%502 0.000 0.020 1.000
history write00:27:36.311 1.2%1085368 0.211 1.526 16.349
hiswrite/artcncl00:00:00.002 0.0%2 1.000 1.000 1.000
idle35:30:55.468 92.6%184958452 0.380 0.691 2482.256
nntp read00:34:05.248 1.5%186478424 0.000 0.011 0.100
overview write00:00:02.820 0.0%1085227 0.000 0.003 0.004
perl filter00:49:46.738 2.2%1085368 1.804 2.752 34.000
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:27.419 0.0%2184960 0.000 0.013 0.016
TOTAL: 38:20:27.72538:06:27.368 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.061 0.0%50241 0.000 0.001 0.020
article prepare00:00:00.001 0.0%8368 0.000 0.000 0.014
article read00:00:19.919 0.0%2088 0.000 9.540 106.333
backlog stats00:00:00.069 0.0%136100 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.541 0.0%63479 0.000 0.009 0.049
data write00:00:01.457 0.0%50028 0.000 0.029 0.091
idle38:29:01.898100.0%136100 516.801 1017.942 9534.095
status file00:00:18.718 0.0%14984 0.467 1.249 23.667
TOTAL: 38:29:47.06038:29:42.664100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:48:33.353 95.1%20355 0.000 143.127300045.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.843 0.0%41231 0.000 0.020 3.033
readart00:00:00.049 0.0%24 0.000 2.042 24.500
TOTAL: 00:51:02.59700:48:34.245 95.2%----

Control commands to INND:

CommandNumber
flush 42
flushlogs 2
go 2
logmode 2
lowmark 1
mode 239
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 299

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000200
TOTAL000200

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 244 10986671098559 0 108 99%113:57:13
2news.icm.edu.pl 59 404 136 235 33 33%19:58:54
3localhost 2334 4 4 0 0 100%00:00:02
TOTAL: 3 2637 10990751098699 235 141 99%133:56:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl442.6 GB1.5 MB1.7 MB442.6 GB 99%422.4 KB
2news.icm.edu.pl4.6 MB0.0 KB990.0 KB5.6 MB 82%33.8 KB
3localhost5.8 KB0.0 KB0.0 KB5.8 KB100%1.4 KB
TOTAL: 3442.6 GB1.5 MB2.6 MB442.6 GB 99%422.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 7 04:15:01 - 04:59:59 26052 2.4% 9.6511.4 GB 0.0%4411.51
Jun 7 05:00:00 - 05:59:59 30859 2.8% 8.5714.5 GB 0.0%4230.55
Jun 7 06:00:00 - 06:59:59 33447 3.0% 9.2915.2 GB 0.0%4420.09
Jun 7 07:00:00 - 07:59:59 34378 3.1% 9.5516.0 GB 0.0%4654.99
Jun 7 08:00:00 - 08:59:59 32970 3.0% 9.1615.0 GB 0.0%4363.62
Jun 7 09:00:00 - 09:59:59 29333 2.7% 8.1514.4 GB 0.0%4188.80
Jun 7 10:00:00 - 10:59:59 29244 2.7% 8.1214.2 GB 0.0%4131.76
Jun 7 11:00:00 - 11:59:59 37066 3.4% 10.3015.0 GB 0.0%4379.76
Jun 7 12:00:00 - 12:59:59 35111 3.2% 9.7514.0 GB 0.0%4072.50
Jun 7 13:00:00 - 13:59:59 34862 3.2% 9.6813.5 GB 0.0%3937.45
Jun 7 14:00:00 - 14:59:59 36302 3.3% 10.0814.2 GB 0.0%4131.96
Jun 7 15:00:00 - 15:59:59 39625 3.6% 11.0115.6 GB 0.0%4531.94
Jun 7 16:00:00 - 16:59:59 35508 3.2% 9.8614.7 GB 0.0%4287.04
Jun 7 17:00:00 - 17:59:59 34846 3.2% 9.6815.1 GB 0.0%4410.53
Jun 7 18:00:00 - 18:59:59 39713 3.6% 11.0315.1 GB 95.7%4390.58
Jun 7 19:00:00 - 19:59:59 33108 3.0% 9.2013.9 GB 88.4%4052.22
Jun 7 20:00:00 - 20:59:59 34413 3.1% 9.5615.5 GB 98.3%4507.47
Jun 7 21:00:00 - 21:59:59 34627 3.1% 9.6215.5 GB 98.5%4515.47
Jun 7 22:00:00 - 22:59:59 39158 3.6% 10.8815.7 GB 100.0%4585.79
Jun 7 23:00:00 - 23:59:59 43615 4.0% 12.1216.0 GB 101.7%4665.96
Jun 8 00:00:00 - 00:59:59 43771 4.0% 12.1615.5 GB 98.6%4519.83
Jun 8 01:00:00 - 01:59:59 36299 3.3% 10.0814.4 GB 91.4%4191.95
Jun 8 02:00:00 - 02:59:59 1929 0.2% 0.54956.8 MB 5.9% 272.15
Jun 8 03:00:00 - 03:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 04:00:00 - 04:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 05:00:00 - 05:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 06:00:00 - 06:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 07:00:00 - 07:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 08:00:00 - 08:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 09:00:00 - 09:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 10:00:00 - 10:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 11:00:00 - 11:59:59 20601 1.9% 5.728.9 GB 56.8%2606.48
Jun 8 12:00:00 - 12:59:59 33634 3.1% 9.3414.2 GB 90.2%4137.04
Jun 8 13:00:00 - 13:59:59 32138 2.9% 8.9314.9 GB 94.9%4351.23
Jun 8 14:00:00 - 14:59:59 32159 2.9% 8.9314.3 GB 91.0%4173.49
Jun 8 15:00:00 - 15:59:59 44047 4.0% 12.2414.0 GB 88.8%4070.93
Jun 8 16:00:00 - 16:59:59 36223 3.3% 10.0615.0 GB 95.3%4368.20
Jun 8 17:00:00 - 17:59:59 26873 2.4% 7.4610.0 GB 63.6%2915.59
Jun 8 18:00:00 - 18:59:59 35026 3.2% 9.739.2 GB 58.3%2675.52
Jun 8 19:00:00 - 19:59:59 25681 2.3% 7.135.4 GB 34.4%1576.59
Jun 8 20:00:00 - 20:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 21:00:00 - 21:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 22:00:00 - 22:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 8 23:00:00 - 23:59:59 1 0.0% 0.001.3 KB 0.0% 0.00
Jun 9 00:00:00 - 00:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 9 01:00:00 - 01:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 9 02:00:00 - 02:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Jun 9 03:00:00 - 03:59:59 31151 2.8% 8.659.1 GB 57.9%2655.89
Jun 9 04:00:00 - 04:15:01 5947 0.5% 6.602.7 GB 17.3%3168.43
TOTAL: 48:00:00 1099717 100.0% 6.3615.7 GB 100.0% 95.54
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 701 87 0 11 9 0 0 0 594
2news.icm.edu.pl 53 0 0 0 0 0 0 0 53
TOTAL: 2 754 87 0 11 9 0 0 0 647

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 36
it.comp.os.win.windows10 15
alt.comp.software.seamonkey 13
it.tlc.cellulari.android 9
comp.sys.raspberry-pi 8
de.comp.lang.php 5
comp.mobile.android 1
TOTAL: 7 87

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

GroupsCount
pl.praca.oferowana 5
pl.sci.matematyka 4
TOTAL: 2 9

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 30
Binary in non-binary group 15
TOTAL: 2 45

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 593
news.icm.edu.pl 9
TOTAL: 2 602
TOTAL: 1 602

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 25559 745 12496 554 0 0 2%31:12:34
2panorama 39238 313 14053 116 2 36226 0%38:46:03
3poznan 35 0 31 0 0 0 0%01:32:19
4nask 0 0 0 0 0 9300 0%38:26:35
5okapi 0 0 0 0 0 1227 0%38:26:35
TOTAL: 5 64832 1058 26580 670 2 46753 1%148:24:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm3.7 MB114.3 MB118.1 MB1.1 KB/s93.1 KB31:12:34
2panorama937.2 KB641.2 KB1.5 MB0.0 KB/s3.7 KB38:46:03
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:32:19
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s038:26:35
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s038:26:35
TOTAL: 54.6 MB115.0 MB119.6 MB0.2 KB/s70.9 KB148:24:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 463 2255.8 KB 11 0 000:00:22
2194.28.48.108 1 22.8 KB 2 0 000:02:15
3isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 3 468 2458.6 KB 13 4 000:51:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 467 2255.8 KB 11 4 000:00:23
2unresolved 170 22.8 KB 2 0 000:03:46
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.pionier.net.pl4425 00.0 KB 0 0 000:39:11
5*.icm.edu.pl 874 00.0 KB 0 0 000:07:40
6*.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 65938 2458.6 KB 13 4 000:51:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
newsfeed.pionier.net.pl 12.750 17.562 0.00000:39:11
news.icm.edu.pl 2.683 3.580 0.00000:07:40
194.28.48.108 0.026 0.029 0.00000:02:15
212.191.227.2 0.028 0.009 0.00000:01:22
web.man.lodz.pl 1.428 2.424 0.00000:00:22
80.111.142.213 0.011 0.049 0.00000:00:03
212.51.192.185 0.401 0.723 0.00000:00:02
monitoring.internet-measurement.com 0.010 0.000 0.00000:00:02
62.233.50.179 0.000 0.009 0.00000:00:01
scanner-05.ch1.censys-scanner.com 0.000 0.010 0.00000:00:00
192.241.222.141 0.000 0.008 0.00000:00:00
isvcs01.man.lodz.pl 0.021 0.028 0.00000:00:00
TOTAL: 12 17.358 24.431 0.00000:51:03

Curious NNRP server explorers [Top 20]:

SystemConn
newsfeed.pionier.net.pl 4425
news.icm.edu.pl 874
212.51.192.185 155
80.111.142.213 7
212.191.227.2 5
192.241.222.141 1
monitoring.internet-measurement.com 1
scanner-05.ch1.censys-scanner.com 1
62.233.50.179 1
TOTAL: 9 5470

NNRP unrecognized commands (by host):

SystemConn
192.241.222.141 1
scanner-05.ch1.censys-scanner.com 1
62.233.50.179 1
TOTAL: 3 3

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_212.191.2.21_119 1
#003 1
EHLO www.censys.io 1
TOTAL: 3 3

Newsgroup request counts (by category):

CategoryCountPct
1pl 22 91.7%
2lodman 2 8.3%
TOTAL: 2 24100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 16
2pl.comp.pecet 6
3lodman.info 1
4lodman.test 1
TOTAL: 4 24