Daily Usenet report

Feb 15 04:15:02 -- Feb 16 04:15:01

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Feb 15 09:42:03 newsfeed overchan[292378]: input line too long, skipping
Feb 15 14:41:58 newsfeed nnrpd[320169]: SERVER perl filter not defined
Feb 15 15:12:09 newsfeed nnrpd[321632]: SERVER perl filter not defined
Feb 15 16:06:14 newsfeed overchan[292378]: input line too long, skipping
Feb 15 16:24:33 newsfeed overchan[292378]: input line too long, skipping
Feb 15 16:25:11 newsfeed overchan[292378]: input line too long, skipping
Feb 15 17:00:06 newsfeed pgpverify[326910]: pgpverify: /usr/bin/gpg1: no such file
Feb 15 17:00:07 newsfeed pgpverify[326923]: pgpverify: /usr/bin/gpg1: no such file
Feb 15 17:23:01 newsfeed overchan[292378]: input line too long, skipping
Feb 15 17:29:45 newsfeed overchan[292378]: input line too long, skipping
Feb 15 18:26:04 newsfeed overchan[292378]: input line too long, skipping
Feb 15 19:27:08 newsfeed overchan[292378]: input line too long, skipping
Feb 15 20:09:30 newsfeed overchan[292378]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1068736 96.5%116.8 MB 96.0%
innfeed 24007 2.2%2.9 MB 2.3%
innd 11100 1.0%1.7 MB 1.4%
nnrpd 3480 0.3%332.0 KB 0.3%
controlchan 23 0.0%4.9 KB 0.0%
overchan 10 0.0%1.6 KB 0.0%
pgpverify 2 0.0%0.5 KB 0.0%
TOTAL: 71107358 100.0%121.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1065635 99.8%
Negative hits 2193 0.2%
Positive hits 265 0.0%
Cache misses 39 0.0%
TOTAL: 4 1068132 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.686 0.0%72 0.000 9.528 58.000
article cleanup00:00:04.495 0.0%1069473 0.002 0.004 0.010
article logging00:00:16.475 0.0%1069840 0.011 0.015 0.031
article parse00:06:46.455 0.5%183662581 0.002 0.002 0.003
article write00:04:37.580 0.3%1069257 0.147 0.260 0.488
artlog/artcncl00:00:00.000 0.0%71 0.000 0.000 0.000
data move00:00:45.572 0.1%191220018 0.000 0.000 0.000
hisgrep/artcncl00:00:00.137 0.0%71 0.000 1.930 13.000
hishave/artcncl00:00:00.004 0.0%72 0.000 0.056 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:04:23.493 0.3%1072144 0.092 0.246 3.498
history sync00:00:00.007 0.0%290 0.000 0.024 1.000
history write00:16:53.011 1.2%1069437 0.141 0.947 12.021
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle22:24:16.022 93.4%182750701 0.316 0.441 0.710
nntp read00:18:44.080 1.3%182920396 0.005 0.006 0.007
overview write00:00:02.139 0.0%1069257 0.001 0.002 0.004
perl filter00:30:22.390 2.1%1069437 1.361 1.704 2.156
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:18.252 0.0%2148104 0.007 0.008 0.012
TOTAL: 24:00:00.87523:47:30.798 99.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.030 0.0%29582 0.000 0.001 0.017
article prepare00:00:00.000 0.0%4548 0.000 0.000 0.000
article read00:00:11.056 0.0%1170 0.000 9.450 106.250
backlog stats00:00:00.032 0.0%78333 0.000 0.000 0.007
callbacks00:00:00.000 0.0%32 0.000 0.000 0.000
data read00:00:00.264 0.0%37420 0.000 0.007 0.029
data write00:00:00.544 0.0%27975 0.000 0.019 0.064
idle23:55:06.053100.0%78333 676.972 1099.231 2460.307
status file00:00:05.985 0.0%7807 0.121 0.767 15.647
TOTAL: 23:55:26.04723:55:23.964100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:24.088 19.5%2784 0.000 30.204 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.047 0.0%5930 0.000 0.008 0.500
readart00:00:00.001 0.0%26 0.000 0.038 0.500
TOTAL: 00:07:10.50000:01:24.136 19.5%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 141 10680281067862 0 166 99%74:31:17
2news.icm.edu.pl 40 431 183 198 50 42%17:38:43
3localhost 1443 2 2 0 0 100%00:00:00
TOTAL: 3 1624 10684611068047 198 216 99%92:10:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl368.6 GB2.6 MB3.1 MB368.7 GB 99%361.9 KB
2news.icm.edu.pl6.6 MB0.0 KB625.5 KB7.2 MB 91%31.8 KB
3localhost3.0 KB0.0 KB0.0 KB3.0 KB100%1.5 KB
TOTAL: 3368.7 GB2.6 MB3.7 MB368.7 GB 99%361.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 15 04:15:02 - 04:59:59 45961 4.3% 17.0410.8 GB 2.9%4187.78
Feb 15 05:00:00 - 05:59:59 35143 3.3% 9.7615.2 GB 4.1%4426.90
Feb 15 06:00:00 - 06:59:59 33299 3.1% 9.2515.4 GB 4.2%4493.10
Feb 15 07:00:00 - 07:59:59 31664 3.0% 8.8014.5 GB 3.9%4236.06
Feb 15 08:00:00 - 08:59:59 30608 2.9% 8.5012.9 GB 3.5%3766.40
Feb 15 09:00:00 - 09:59:59 35380 3.3% 9.8315.0 GB 4.1%4376.83
Feb 15 10:00:00 - 10:59:59 37515 3.5% 10.4214.9 GB 4.0%4333.41
Feb 15 11:00:00 - 11:59:59 43555 4.1% 12.1015.5 GB 4.2%4501.10
Feb 15 12:00:00 - 12:59:59 61799 5.8% 17.1716.4 GB 4.4%4769.18
Feb 15 13:00:00 - 13:59:59 70746 6.6% 19.6517.1 GB 4.6%4989.61
Feb 15 14:00:00 - 14:59:59 44229 4.1% 12.2915.2 GB 4.1%4432.30
Feb 15 15:00:00 - 15:59:59 47866 4.5% 13.3014.1 GB 3.8%4112.35
Feb 15 16:00:00 - 16:59:59 60040 5.6% 16.6816.2 GB 4.4%4707.66
Feb 15 17:00:00 - 17:59:59 38759 3.6% 10.7715.6 GB 4.2%4551.88
Feb 15 18:00:00 - 18:59:59 41242 3.9% 11.4615.9 GB 4.3%4619.87
Feb 15 19:00:00 - 19:59:59 43274 4.1% 12.0215.5 GB 4.2%4525.96
Feb 15 20:00:00 - 20:59:59 48505 4.5% 13.4715.9 GB 4.3%4637.03
Feb 15 21:00:00 - 21:59:59 48884 4.6% 13.5815.3 GB 4.2%4469.68
Feb 15 22:00:00 - 22:59:59 65969 6.2% 18.3216.5 GB 4.5%4792.27
Feb 15 23:00:00 - 23:59:59 38276 3.6% 10.6315.3 GB 4.1%4451.31
Feb 16 00:00:00 - 00:59:59 43023 4.0% 11.9515.7 GB 4.3%4568.17
Feb 16 01:00:00 - 01:59:59 41233 3.9% 11.4517.2 GB 4.7%5008.71
Feb 16 02:00:00 - 02:59:59 38917 3.6% 10.8117.3 GB 4.7%5048.22
Feb 16 03:00:00 - 03:59:59 36426 3.4% 10.1212.5 GB 3.4%3630.84
Feb 16 04:00:00 - 04:15:01 5767 0.5% 6.402.6 GB 0.7%3051.75
TOTAL: 23:59:59 1068080 100.0% 12.36368.6 GB 100.0%4473.01
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 532 115 0 36 15 0 0 0 366
2news.icm.edu.pl 53 0 0 0 0 0 0 0 53
TOTAL: 2 585 115 0 36 15 0 0 0 419

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 89
it.comp.os.win.windows10 15
comp.mobile.android 6
alt.comp.software.seamonkey 4
alt.comp.software.firefox 1
TOTAL: 5 115

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

GroupsCount
pl.praca.oferowana 15
TOTAL: 1 15

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 45
Scoring filter (8) 5
TOTAL: 2 50

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 366
news.icm.edu.pl 3
TOTAL: 2 369
TOTAL: 1 369

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15367 534 8455 17 0 0 3%23:59:43
2panorama 20260 119 7189 158 66 22135 0%23:59:57
3poznan 198 0 158 4 0 0 0%04:12:59
4nask 0 0 0 0 0 6945 0%23:57:48
5okapi 0 0 0 0 0 654 0%23:57:48
TOTAL: 5 35825 653 15802 179 66 29734 1%100:08:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.9 MB57.7 KB2.0 MB0.0 KB/s3.7 KB23:59:43
2panorama327.0 KB1.0 MB1.3 MB0.0 KB/s4.9 KB23:59:57
3poznan0.0 KB97.6 KB97.6 KB0.0 KB/s24.4 KB04:12:59
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 52.2 MB1.2 MB3.4 MB0.0 KB/s4.2 KB100:08:15
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 293 2637.3 KB 12 0 000:00:08
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 295 2637.3 KB 12 2 000:07:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 295 2637.3 KB 12 2 000:00:08
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3unresolved 133 00.0 KB 0 0 000:06:59
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 430 2637.3 KB 12 2 000:07:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
109.74.204.123 0.085 0.140 0.00000:06:46
104.152.52.113 0.000 0.007 0.00000:00:10
web.man.lodz.pl 0.550 1.624 0.00000:00:08
swanky.monitoring.internet-measurement.com 0.000 0.006 0.00000:00:01
80.111.142.213 0.011 0.018 0.00000:00:01
212.51.192.185 0.202 0.429 0.00000:00:00
scanner-04.ch1.censys-scanner.com 0.003 0.005 0.00000:00:00
104.152.52.201 0.003 0.003 0.00000:00:00
192.241.198.11 0.000 0.006 0.00000:00:00
isvcs01.man.lodz.pl 0.000 0.021 0.00000:00:00
TOTAL: 10 0.854 2.259 0.00000:07:10

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
109.74.204.123 30
80.111.142.213 4
192.241.198.11 1
scanner-04.ch1.censys-scanner.com 1
swanky.monitoring.internet-measurement.com 1
104.152.52.113 1
104.152.52.201 1
TOTAL: 8 135

NNRP unrecognized commands (by host):

SystemConn
109.74.204.123 2
scanner-04.ch1.censys-scanner.com 1
192.241.198.11 1
TOTAL: 3 4

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_212.191.2.21_119 1
À#024 1
EHLO www.censys.io 1
#026#003#001#002 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
109.74.204.123 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 26100.0%
TOTAL: 1 26100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 16
2pl.comp.pecet 10
TOTAL: 2 26