Daily Usenet report

May 4 04:15:02 -- May 5 04:15:01

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

May 4 07:59:30 newsfeed overchan[122863]: input line too long, skipping
May 4 08:12:06 newsfeed overchan[122863]: input line too long, skipping
May 4 10:44:37 newsfeed overchan[122863]: input line too long, skipping
May 4 11:40:45 newsfeed overchan[122863]: input line too long, skipping
May 4 15:06:14 newsfeed overchan[122863]: input line too long, skipping
May 4 15:18:34 newsfeed overchan[122863]: input line too long, skipping
May 4 15:22:06 newsfeed overchan[122863]: input line too long, skipping
May 4 15:27:02 newsfeed overchan[122863]: input line too long, skipping
May 4 17:27:36 newsfeed overchan[122863]: input line too long, skipping
May 4 17:41:15 newsfeed overchan[122863]: input line too long, skipping
May 4 18:17:12 newsfeed overchan[122863]: input line too long, skipping
May 4 18:26:42 newsfeed overchan[122863]: input line too long, skipping
May 4 18:28:41 newsfeed overchan[122863]: input line too long, skipping
May 4 21:06:34 newsfeed overchan[122863]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 873149 94.7%95.9 MB 94.2%
innfeed 35340 3.8%4.2 MB 4.1%
nnrpd 7669 0.8%854.9 KB 0.8%
innd 5366 0.6%900.7 KB 0.9%
overchan 15 0.0%2.5 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 921540 100.0%101.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 869782 99.9%
Negative hits 904 0.1%
Positive hits 194 0.0%
Cache misses 33 0.0%
TOTAL: 4 870913 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.476 0.0%63 0.000 7.556 21.000
article cleanup00:00:03.848 0.0%873378 0.002 0.004 0.009
article logging00:00:12.824 0.0%873750 0.010 0.015 0.049
article parse00:04:44.684 0.3%141265994 0.002 0.002 0.003
article write00:03:29.053 0.2%873211 0.085 0.239 0.607
artlog/artcncl00:00:00.000 0.0%63 0.000 0.000 0.000
data move00:00:20.868 0.0%147023233 0.000 0.000 0.000
hisgrep/artcncl00:00:00.073 0.0%56 0.000 1.304 17.000
hishave/artcncl00:00:00.017 0.0%63 0.000 0.270 1.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:06:44.297 0.5%874699 0.106 0.462 12.862
history sync00:00:00.009 0.0%290 0.000 0.031 1.000
history write00:21:28.063 1.5%873343 0.189 1.475 14.324
hiswrite/artcncl00:00:00.017 0.0%7 0.500 2.429 13.000
idle22:39:37.317 94.4%140675809 0.407 0.580 0.940
nntp read00:12:59.905 0.9%140579635 0.005 0.006 0.007
overview write00:00:01.770 0.0%873211 0.001 0.002 0.004
perl filter00:24:28.319 1.7%873343 1.277 1.681 2.296
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:14.396 0.0%1756581 0.005 0.008 0.012
TOTAL: 24:00:01.34623:54:25.936 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.045 0.0%37681 0.000 0.001 0.009
article prepare00:00:00.001 0.0%5652 0.000 0.000 0.006
article read00:00:14.131 0.0%1424 0.000 9.923 109.000
backlog stats00:00:00.037 0.0%92874 0.000 0.000 0.004
callbacks00:00:00.000 0.0%29 0.000 0.000 0.000
data read00:00:00.317 0.0%44457 0.000 0.007 0.034
data write00:00:00.575 0.0%34602 0.000 0.017 0.049
idle23:53:37.259100.0%92874 495.676 926.172 2115.032
status file00:00:19.637 0.0%12736 0.176 1.542 56.953
TOTAL: 23:54:13.93223:54:12.002100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:00:23.353 99.6%4190 0.000 864.762360094.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.105 0.0%10222 0.000 0.010 0.500
readart00:00:00.163 0.0%23 0.000 7.087 7.762
TOTAL: 01:00:39.42901:00:23.621 99.6%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 52 872459 872341 1 117 99%54:27:28
2news.icm.edu.pl 39 255 72 134 49 28%13:45:04
3localhost 1 0 0 0 0 0%00:00:00
TOTAL: 3 92 872714 872413 135 166 99%68:12:32
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl260.9 GB2.1 MB2.4 MB260.9 GB 99%313.5 KB
2news.icm.edu.pl3.5 MB45.0 KB852.7 KB4.4 MB 79%36.8 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3260.9 GB2.2 MB3.2 MB260.9 GB 99%313.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 4 04:15:02 - 04:59:59 23607 2.7% 8.757.4 GB 2.8%2861.98
May 4 05:00:00 - 05:59:59 22103 2.5% 6.1410.2 GB 3.9%2979.46
May 4 06:00:00 - 06:59:59 23187 2.7% 6.4410.8 GB 4.1%3151.49
May 4 07:00:00 - 07:59:59 25407 2.9% 7.0611.0 GB 4.2%3218.42
May 4 08:00:00 - 08:59:59 23437 2.7% 6.5110.4 GB 4.0%3021.34
May 4 09:00:00 - 09:59:59 25586 2.9% 7.1110.7 GB 4.1%3112.26
May 4 10:00:00 - 10:59:59 25992 3.0% 7.2210.8 GB 4.1%3141.14
May 4 11:00:00 - 11:59:59 24833 2.8% 6.9010.5 GB 4.0%3047.67
May 4 12:00:00 - 12:59:59 25538 2.9% 7.0911.0 GB 4.2%3216.72
May 4 13:00:00 - 13:59:59 62232 7.1% 17.2911.0 GB 4.2%3213.04
May 4 14:00:00 - 14:59:59 65706 7.5% 18.2510.5 GB 4.0%3057.22
May 4 15:00:00 - 15:59:59 60746 7.0% 16.879.5 GB 3.6%2777.08
May 4 16:00:00 - 16:59:59 41459 4.8% 11.5210.8 GB 4.1%3148.35
May 4 17:00:00 - 17:59:59 45322 5.2% 12.5911.7 GB 4.5%3413.19
May 4 18:00:00 - 18:59:59 49114 5.6% 13.6411.7 GB 4.5%3400.11
May 4 19:00:00 - 19:59:59 81492 9.3% 22.6411.7 GB 4.5%3398.15
May 4 20:00:00 - 20:59:59 38969 4.5% 10.8210.1 GB 3.9%2938.61
May 4 21:00:00 - 21:59:59 29824 3.4% 8.2810.2 GB 3.9%2966.73
May 4 22:00:00 - 22:59:59 40439 4.6% 11.2312.0 GB 4.6%3482.36
May 4 23:00:00 - 23:59:59 31821 3.6% 8.8411.8 GB 4.5%3440.86
May 5 00:00:00 - 00:59:59 24878 2.9% 6.9110.4 GB 4.0%3029.64
May 5 01:00:00 - 01:59:59 26543 3.0% 7.3711.9 GB 4.5%3467.71
May 5 02:00:00 - 02:59:59 22010 2.5% 6.1111.6 GB 4.4%3365.76
May 5 03:00:00 - 03:59:59 23879 2.7% 6.6310.4 GB 4.0%3021.67
May 5 04:00:00 - 04:15:01 8423 1.0% 9.353.8 GB 1.5%4427.72
TOTAL: 23:59:59 872547 100.0% 10.10261.8 GB 100.0%3177.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 486 82 0 33 0 0 0 0 371
2news.icm.edu.pl 53 0 0 2 0 0 0 0 51
TOTAL: 2 539 82 0 35 0 0 0 0 422

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 38
comp.mobile.android 17
it.tlc.cellulari.android 10
alt.comp.software.seamonkey 6
de.comm.provider.telefonie 5
de.comp.lang.perl 3
comp.mobile.ipad 2
it.comp.os.win.windows7 1
TOTAL: 8 82

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 20
Scoring filter (15) 14
Scoring filter (8) 5
Binary in non-binary group 4
Scoring filter (11) 4
Scoring filter (13) 3
TOTAL: 6 50

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 31402 195 10003 186 52 27330 0%23:59:57
2icm 15333 25 9136 595 0 1 0%23:59:53
3nask 0 0 0 0 0 6439 0%23:57:46
4poznan 64 0 57 0 0 0 0%03:06:18
5okapi 0 0 0 0 0 502 0%23:57:46
TOTAL: 5 46799 220 19196 781 52 34272 0%99:01:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama893.1 KB1.1 MB2.0 MB0.0 KB/s5.4 KB23:59:57
2icm133.7 KB78.6 MB78.7 MB0.9 KB/s130.0 KB23:59:53
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:06:18
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
TOTAL: 51.0 MB79.7 MB80.7 MB0.2 KB/s82.6 KB99:01:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
146.219.209.156 1 1926.3 KB 1 0 000:00:03
2web.man.lodz.pl 296 22.2 KB 1 0 000:00:08
TOTAL: 2 297 2128.5 KB 2 0 001:00:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 104 1926.3 KB 1 0 000:00:17
2*.man.lodz.pl1738 22.2 KB 1 0 001:00:22
TOTAL: 21842 2128.5 KB 2 0 001:00:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-tom.man.lodz.pl 0.004 0.010 0.00001:00:01
nms2.man.lodz.pl 2.200 8.265 0.00000:00:12
104.152.52.118 0.000 0.007 0.00000:00:10
web.man.lodz.pl 0.540 1.755 0.00000:00:08
46.219.209.156 0.000 0.022 0.00000:00:03
80.111.142.213 0.006 0.028 0.00000:00:02
212.51.192.185 0.140 0.566 0.00000:00:00
94.102.61.41 0.000 0.007 0.00000:00:00
80.66.77.238 0.003 0.003 0.00000:00:00
TOTAL: 9 2.893 10.663 0.00001:00:40

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
pc-tom.man.lodz.pl 2
104.152.52.118 1
80.66.77.238 1
94.102.61.41 1
TOTAL: 7 1545

NNRP unrecognized commands (by host):

SystemConn
94.102.61.41 5
80.66.77.238 5
TOTAL: 2 10

NNRP unrecognized commands (by command):

CommandCount
Host: 212.191.2.21:119 2
Accept-Encoding: gzip 2
Accept: */* 2
GET / HTTP/1.1 2
User-Agent: Mozilla/5.0 zgrab/0.x 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 6 10

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-tom.man.lodz.pl 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 19 90.5%
2pl 2 9.5%
TOTAL: 2 21100.0%

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

NewsgroupCount
1lodman.info 19
2pl.comp.pecet 2
TOTAL: 2 21
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>