Archive for March 21st, 2014

sessione di debug

March 21st, 2014 | Category: tmrc
spesso vengo chiamato dal Sig. M.
che lavora in un… posto pubblico, dove c’è il servizio hotspot offerto dalla Micso
quando mi deve comunicare gli username (lunghissimi) che hanno problemi, me li dice sempre a coppie:
esempio: 28254473899078389
“ventotto…..”
“venticinque….”“quarantasette…”

…con un tono di voce come se stesse leggendo l’estrazione dei numeri al lotto 😀

in questi giorni mi ha segnalato un paio di volte che gli utenti andavano lì
provavano a connettersi e il Sistema ( 😀 ) gli rispondeva che il tempo era già scaduto

gli accessi sono infatti da 1 ora al giorno

insomma, era come se avessero già consumato, per quel giorno, l’ora di navigazione.
anche se quel giorno non erano ancora mai andati lì

non  vi dico allora la psicosi che si era creata, gente che era convinta che il proprio accesso fosse usato anche da altri etc…

poco fa mi ha richiamato.

un ragazzo (andrea) non riusciva ad accedere

gli ho detto allora.. di farlo riprovare, non prima di aver attivato la modalità debug sul log del Sistema (radius -X)

(che genera una quantità di informazioni incredibilmente dettagliata)

gli ho detto di farlo provare, e di richiamarmi

dopo qualche minuto… mi ha richiamato. non ha funzionato

gli ho detto allora: bene, mi ci vuole un po’ di tempo però..

no, meglio se il ragazzo non lo fai aspettare..

sul file di log c’erano scritte tutte le query mysql che vengono eseguite quando l’utente tenta di loggarsi
allora non c’è niente di più bello che RIFARLE una per una e vedere se magari spunta fuori qualche errore.

 

mysql> SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName=’xxxxxxxxxxxxxx’;
+———————-+
| SUM(AcctSessionTime) |
+———————-+
|                 3600 |
+———————-+
1 row in set (0.00 sec)
..ma qui non c’è nessun errore.. anzi dice veramente che sono già stati consumati 3600 secondi!

allora intanto ho tolto “SUM” dalla query, per vedere se questi 3600 erano stati fatti tutti in una botta, o in più volte..
mysql> SELECT AcctSessionTime FROM radacct WHERE UserName=’xxxxxxxxxxxxxx’;
+—————–+
| AcctSessionTime |
+—————–+
|            1668 |
|             433 |
|            1499 |
+—————–+
3 rows in set (0.00 sec)

mm
sembra che l’utente abbia fatto “in 3 botte”. ma in che giorni?
mysql> SELECT AcctSessionTime,AcctStartTime FROM radacct WHERE UserName=’xxxxxxxxxxxxxxxx’;
+—————–+———————+
| AcctSessionTime | AcctStartTime       |
+—————–+———————+
|            1668 | 2014-02-21 14:19:00 |
|             433 | 2014-02-21 15:09:59 |
|            1499 | 2014-02-26 09:02:35 |
+—————–+———————+
3 rows in set (0.00 sec)
ma.. sono tutte navigazioni fatte a febbraio!
allora mi s’è accesa la lampadina 🙂
qualche mese fa gli accessi lì nel posto pubblico erano finiti, e qualcuno ne ha generato di nuovi.
MAAAAAAAAAA..
al posto di creare accessi della tipologia “ORE1DAY” (3600 secondi al giorno) ha creato “ORE1” (che.. indovinate un po’.. vuol dire 3600 secondi IN TOTALE, a scalare. )
è bastato dunque convertire tutti gli accessi da una tipologia all’altra 🙂
sessione di debug conclusa.
vai Andre’!
No comments