Daily Usenet report

Sep 11 04:15:01 -- Sep 12 04:15:02

Unknown entries from news log file:

First 33 / 33 lines (100.0%)

Sep 11 06:49:20 newsfeed overchan[361725]: input line too long, skipping
Sep 11 06:51:37 newsfeed overchan[361725]: input line too long, skipping
Sep 11 08:36:20 newsfeed overchan[361725]: input line too long, skipping
Sep 11 10:42:34 newsfeed overchan[361725]: input line too long, skipping
Sep 11 14:41:09 newsfeed nnrpd[392114]: SERVER perl filter not defined
Sep 11 14:42:04 newsfeed nnrpd[392127]: SERVER perl filter not defined
Sep 11 14:42:58 newsfeed nnrpd[392136]: SERVER perl filter not defined
Sep 11 14:44:04 newsfeed nnrpd[392147]: SERVER perl filter not defined
Sep 11 14:45:13 newsfeed nnrpd[392252]: SERVER perl filter not defined
Sep 11 14:50:51 newsfeed nnrpd[392549]: SERVER perl filter not defined
Sep 11 14:51:35 newsfeed nnrpd[392553]: SERVER perl filter not defined
Sep 11 14:52:33 newsfeed nnrpd[392564]: SERVER perl filter not defined
Sep 11 14:53:57 newsfeed nnrpd[392580]: SERVER perl filter not defined
Sep 11 14:55:23 newsfeed nnrpd[392693]: SERVER perl filter not defined
Sep 11 14:56:07 newsfeed nnrpd[392701]: SERVER perl filter not defined
Sep 11 14:57:07 newsfeed nnrpd[392713]: SERVER perl filter not defined
Sep 11 15:05:53 newsfeed overchan[361725]: input line too long, skipping
Sep 11 19:49:59 newsfeed overchan[361725]: input line too long, skipping
Sep 11 20:36:42 newsfeed overchan[361725]: input line too long, skipping
Sep 11 20:38:45 newsfeed overchan[361725]: input line too long, skipping
Sep 11 20:43:13 newsfeed overchan[361725]: input line too long, skipping
Sep 11 20:44:48 newsfeed overchan[361725]: input line too long, skipping
Sep 11 23:04:09 newsfeed overchan[361725]: input line too long, skipping
Sep 11 23:06:17 newsfeed overchan[361725]: input line too long, skipping
Sep 11 23:20:42 newsfeed overchan[361725]: input line too long, skipping
Sep 11 23:20:59 newsfeed overchan[361725]: input line too long, skipping
Sep 11 23:21:15 newsfeed overchan[361725]: input line too long, skipping
Sep 12 01:08:20 newsfeed overchan[361725]: input line too long, skipping
Sep 12 01:09:52 newsfeed overchan[361725]: input line too long, skipping
Sep 12 01:39:52 newsfeed overchan[361725]: input line too long, skipping
Sep 12 02:04:28 newsfeed overchan[361725]: input line too long, skipping
Sep 12 02:04:43 newsfeed overchan[361725]: input line too long, skipping
Sep 12 02:05:15 newsfeed overchan[361725]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 159717 93.3%18.7 MB 94.1%
nnrpd 7678 4.5%773.2 KB 3.8%
innd 2311 1.4%273.3 KB 1.3%
innfeed 1416 0.8%142.0 KB 0.7%
overchan 22 0.0%2.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 171145 100.0%19.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 158792 97.5%
Negative hits 3124 1.9%
Positive hits 920 0.6%
Cache misses 27 0.0%
TOTAL: 4 162863 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.040 0.0%58 0.000 17.931 51.750
article cleanup00:00:00.846 0.0%159473 0.000 0.005 0.013
article logging00:00:03.353 0.0%159477 0.009 0.021 0.035
article parse00:00:05.314 0.0%1028014 0.002 0.005 0.010
article write00:00:23.927 0.0%159175 0.046 0.150 0.600
artlog/artcncl00:00:00.004 0.0%54 0.000 0.074 1.000
data move00:00:00.887 0.0%1289290 0.000 0.001 0.003
hisgrep/artcncl00:00:00.336 0.0%57 0.000 5.895 14.556
hishave/artcncl00:00:00.206 0.0%58 0.000 3.552 13.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:15:50.143 1.1%163474 1.523 5.812 34.304
history sync00:00:00.017 0.0%371 0.000 0.046 0.500
history write00:19:21.325 1.3%159439 0.212 7.284 29.316
hiswrite/artcncl00:00:00.010 0.0%1 10.000 10.000 10.000
idle23:21:31.188 97.3%1127574 7.178 74.577 303.479
nntp read00:00:11.718 0.0%1005994 0.006 0.012 0.021
overview write00:00:00.454 0.0%159175 0.000 0.003 0.011
perl filter00:02:38.368 0.2%159439 0.728 0.993 1.416
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:04.408 0.0%330167 0.006 0.013 0.020
TOTAL: 24:00:52.83824:00:13.544100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%11775 0.000 0.002 0.024
article prepare00:00:00.000 0.0%168 0.000 0.000 0.000
article read00:00:00.012 0.0%42 0.000 0.286 1.833
backlog stats00:00:00.029 0.0%51655 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.249 0.0%27378 0.000 0.009 0.034
data write00:00:00.580 0.0%15763 0.000 0.037 0.103
idle23:50:38.735100.0%51655 938.304 1661.770 3549.439
status file00:00:00.445 0.0%387 0.000 1.150 16.000
TOTAL: 23:50:40.99623:50:40.069100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.848 54.8%4255 0.000 4.665 10035.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.132 0.4%10181 0.000 0.013 0.500
readart00:00:00.000 0.0%8 0.000 0.000 0.000
TOTAL: 00:00:36.20000:00:19.980 55.2%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 87 159536 159359 7 170 99%45:10:12
2news.icm.edu.pl 11 1004 36 840 128 3%23:02:38
3localhost 13 12 12 0 0 100%00:00:00
TOTAL: 3 111 160552 159407 847 298 99%68:12:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl2.5 GB539.8 KB979.9 KB2.5 GB 99%16.4 KB
2news.icm.edu.pl1000.9 KB160.1 KB2.8 MB3.9 MB 25%24.4 KB
3localhost18.6 KB0.0 KB0.0 KB18.6 KB100%1.5 KB
TOTAL: 32.5 GB699.9 KB3.7 MB2.5 GB 99%16.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 11 04:15:01 - 04:59:59 4375 2.7% 1.62102.2 MB 4.0% 38.79
Sep 11 05:00:00 - 05:59:59 7857 4.9% 2.18238.7 MB 9.4% 67.89
Sep 11 06:00:00 - 06:59:59 5187 3.3% 1.4469.7 MB 2.7% 19.82
Sep 11 07:00:00 - 07:59:59 4825 3.0% 1.3447.3 MB 1.9% 13.46
Sep 11 08:00:00 - 08:59:59 4594 2.9% 1.2842.2 MB 1.7% 12.01
Sep 11 09:00:00 - 09:59:59 5337 3.3% 1.4845.4 MB 1.8% 12.91
Sep 11 10:00:00 - 10:59:59 5327 3.3% 1.4859.3 MB 2.3% 16.87
Sep 11 11:00:00 - 11:59:59 4545 2.9% 1.2647.6 MB 1.9% 13.53
Sep 11 12:00:00 - 12:59:59 4304 2.7% 1.2042.3 MB 1.7% 12.03
Sep 11 13:00:00 - 13:59:59 6583 4.1% 1.83133.8 MB 5.2% 38.07
Sep 11 14:00:00 - 14:59:59 4729 3.0% 1.3143.1 MB 1.7% 12.25
Sep 11 15:00:00 - 15:59:59 3658 2.3% 1.0241.6 MB 1.6% 11.84
Sep 11 16:00:00 - 16:59:59 7853 4.9% 2.1875.1 MB 2.9% 21.35
Sep 11 17:00:00 - 17:59:59 9133 5.7% 2.54116.8 MB 4.6% 33.23
Sep 11 18:00:00 - 18:59:59 10017 6.3% 2.78116.7 MB 4.6% 33.18
Sep 11 19:00:00 - 19:59:59 8467 5.3% 2.35135.9 MB 5.3% 38.65
Sep 11 20:00:00 - 20:59:59 10218 6.4% 2.84179.7 MB 7.0% 51.11
Sep 11 21:00:00 - 21:59:59 7590 4.8% 2.1164.9 MB 2.5% 18.45
Sep 11 22:00:00 - 22:59:59 7634 4.8% 2.1279.8 MB 3.1% 22.71
Sep 11 23:00:00 - 23:59:59 7447 4.7% 2.07164.6 MB 6.4% 46.82
Sep 12 00:00:00 - 00:59:59 4540 2.8% 1.2638.8 MB 1.5% 11.03
Sep 12 01:00:00 - 01:59:59 4211 2.6% 1.1734.9 MB 1.4% 9.94
Sep 12 02:00:00 - 02:59:59 9670 6.1% 2.69439.9 MB 17.2% 125.12
Sep 12 03:00:00 - 03:59:59 9185 5.8% 2.55170.6 MB 6.7% 48.52
Sep 12 04:00:00 - 04:15:02 2075 1.3% 2.3021.6 MB 0.8% 24.58
TOTAL: 24:00:01 159361 100.0% 1.842.5 GB 100.0% 30.25
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 174 139 0 25 0 0 0 0 10
2news.icm.edu.pl 128 0 0 9 0 0 0 0 119
TOTAL: 2 302 139 0 34 0 0 0 0 129

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 83
it.tlc.cellulari.android 42
alt.comp.software.seamonkey 5
comp.mobile.android 5
de.comp.lang.vbclassic 3
de.comm.software.mailreader 1
TOTAL: 6 139

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 85
Scoring filter (8) 24
EMP (md5) 10
Scoring filter (9) 4
Scoring filter (11) 1
Scoring filter (10) 1
TOTAL: 6 125

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15569 38 11534 4 0 1 0%23:59:56
2panorama 0 0 0 0 0 11814 0%23:57:47
3nask 0 0 0 0 0 8458 0%23:57:47
4okapi 0 0 0 0 0 736 0%23:57:47
5poznan 47 0 35 0 0 0 0%05:07:52
TOTAL: 5 15616 38 11569 4 0 21009 0%101:01:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm119.7 KB14.8 KB134.5 KB0.0 KB/s3.2 KB23:59:56
2panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s005:07:52
TOTAL: 5119.7 KB14.8 KB134.5 KB0.0 KB/s3.2 KB101:01:09
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 290 89.5 KB 4 0 000:00:09
2isvcs01.man.lodz.pl 12 00.0 KB 0 12 000:00:00
TOTAL: 2 302 89.5 KB 4 12 000:00:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1730 89.5 KB 4 12 000:00:22
2unresolved 101 00.0 KB 0 0 000:00:13
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 31832 89.5 KB 4 12 000:00:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 2.687 12.328 0.00000:00:12
172.245.90.197 0.000 0.016 0.00000:00:10
web.man.lodz.pl 0.631 2.678 0.00000:00:09
80.111.142.213 0.005 0.041 0.00000:00:02
212.51.192.185 0.198 0.915 0.00000:00:01
scanner-27.ch1.censys-scanner.com 0.003 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.041 0.113 0.00000:00:00
TOTAL: 7 3.565 16.103 0.00000:00:36

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1428
212.51.192.185 96
80.111.142.213 4
172.245.90.197 1
scanner-27.ch1.censys-scanner.com 1
TOTAL: 5 1530

NNRP unrecognized commands (by host):

SystemConn
scanner-27.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 8100.0%
TOTAL: 1 8100.0%

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

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