lageIBUSP / notaR

Repositório para o código do notaR 4.0
2 stars 2 forks source link

NotaR fora do ar 06/09/2024 #146

Open Lobz opened 1 week ago

Lobz commented 1 week ago

NotaR foi notificado fopra do ar pelo discord:

John Davis — 09/06/2024 7:54 PM Boa noite pessoal, alguém mais está tendo dificuldades para acessar o notaR ? Não consigo acessar a plataforma desde a tarde.

E ficou fora do ar até segunda de manhã (09/09) quando @adalardo reiniciou o serviço com deploy.sh. Precisamos averiguar

  1. Por que o serviço caiu?
  2. Por que o serviço não voltou automaticamente?
Lobz commented 1 week ago

Tail do log:

notaR$ tail storage/logs/laravel-2024-09-06.log 
[2024-09-06 16:34:12] production.INFO: User 322 submitted an answer to exercise 78  
[2024-09-06 16:34:39] production.INFO: User 322 submitted an answer to exercise 78  
[2024-09-06 16:35:40] production.INFO: User 322 submitted an answer to exercise 78  
[2024-09-06 16:36:23] production.INFO: User 322 submitted an answer to exercise 78  
[2024-09-06 16:37:32] production.INFO: User 311 submitted an answer to exercise 33  
[2024-09-06 16:40:11] production.INFO: User 311 submitted an answer to exercise 33  
[2024-09-06 16:44:56] production.INFO: Guest submitted an answer to exercise 36  
[2024-09-06 16:45:08] production.INFO: Guest submitted an answer to exercise 36  
[2024-09-06 16:46:11] production.INFO: User 308 submitted an answer to exercise 112  
[2024-09-06 16:47:24] production.INFO: User 362 submitted an answer to exercise 13

Usando artisan tinker, confirmei que o usuário 362 não tem nota para o exercício 13. (Obs: adicionar logging para notas e não apenas submissões, para facilitar o troubleshooting)

Na pasta temp, onde ficam os arquivos com os códigos, encontrei uma submissão do mesmo dia (certamente o arquivo não foi deletado devido a um crash do serviço). O código era o seguinte:

linhas<-25
colunas<-15
dist<-25*15
desvio<-sqrt(3.6)
distribuição<-rnorm(dist,10,desvio)
distribuição

matNorm <-matrix(distribuição, nrow = linhas, ncol = colunas, byrow = T, 
                 dimnames = list(paste("l",1:25, sep = ""), paste("c", 1:15, sep = "")))  

matNorm
edit(matNorm)

Suspeito que o crash esteja relacionado com o uso da função edit, que abre uma nova janela.

Lobz commented 1 week ago

O journalctl do docker para o dia 6, 19h47 contém apenas isto:

Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.213576580Z" level=debug msg="Name To resolve: mysql." spanID=98e1b065c8d93936 traceID=0abf9bf6998717b8b587b94fcc4dccfa
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.213792164Z" level=debug msg="Name To resolve: mysql." spanID=a0791c17fec593c8 traceID=58e5a394095b040faf71dd63963a5a4a
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.213859643Z" level=debug msg="[resolver] lookup for mysql.: IP [172.31.0.3]" spanID=98e1b065c8d93936 traceID=0abf9bf6998717b8b587b94fcc4dccfa
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.213986732Z" level=debug msg="[resolver] lookup name mysql. present without IPv6 address" spanID=a0791c17fec593c8 traceID=58e5a394095b040faf71dd63963a5a4a
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.229506750Z" level=debug msg="Name To resolve: r." spanID=743dd0cc5362a061 traceID=19371a6c1b5999034de5d542ab5ec0dc
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.229709024Z" level=debug msg="[resolver] lookup for r.: IP [172.31.0.2]" spanID=743dd0cc5362a061 traceID=19371a6c1b5999034de5d542ab5ec0dc
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.807787915Z" level=debug msg="Name To resolve: mysql." spanID=ee48e3424b55a7bc traceID=abf23a6a6320eb3aeca6a624a95180d9
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.807787675Z" level=debug msg="Name To resolve: mysql." spanID=30ff23132c063243 traceID=11ce1bd6efc63a700ba2fa9b24b468fe
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.808291860Z" level=debug msg="[resolver] lookup name mysql. present without IPv6 address" spanID=30ff23132c063243 traceID=11ce1bd6efc63a700ba2fa9b24b468fe
Sep 06 19:47:24 Ecologia dockerd[1297]: time="2024-09-06T19:47:24.808093977Z" level=debug msg="[resolver] lookup for mysql.: IP [172.31.0.3]" spanID=ee48e3424b55a7bc traceID=abf23a6a6320eb3aeca6a624a95180d9
Lobz commented 1 week ago

Por outro lado, o journalctlpara o serviço notaR indica que o vim foi aberto:

$ sudo journalctl -u notaR.service | grep "Sep 06 19:47"
Sep 06 19:47:24 Ecologia docker-compose[233855]: r_1      | Loading required package: RMySQL
Sep 06 19:47:24 Ecologia docker-compose[233855]: r_1      | Loading required package: DBI
Sep 06 19:47:25 Ecologia docker-compose[233855]: r_1      | Vim: Warning: Output is not to a terminal
Sep 06 19:47:25 Ecologia docker-compose[233855]: r_1      | Vim: Warning: Input is not from a terminal
Sep 06 19:47:27 Ecologia docker-compose[233855]: [145B blob data]
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 10.8212144645116, 9.30322125593218, 11.1023633471529, 12.6413551095829,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 10.2001983831814, 7.16604569017492, 7.91837298370428, 9.92278007273584,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 12.7178295171994, 10.2873673518998, 12.0601129382587, 7.72084140642598,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 9.66982361488574, 8.61640749825097, 8.03836253346007, 11.0886173052616,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 10.6603069199991, 9.99123270947774, 9.21008329895709, 11.4168996538515,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 10.5226428511497, 8.3894854503629, 8.92856055271373, 9.46066800206101,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 11.3373348193428, 8.46048969119909, 10.3514502863529, 11.4575166770024,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 9.09652350446168, 9.19882579473485, 7.21004434248477, 9.77740178531205,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 7.05615068172418, 8.1164983892212, 8.89173115117532, 10.7661090165515,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 13.8648829468214, 10.9784107230241, 11.893702607699, 8.59890717975648,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 10.0869061821523, 14.6667506396123, 11.4424580938694, 8.5107800885577,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 9.19263496734449, 12.1959116696029, 7.93467877472992, 10.6889877177667,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 4.95973022034378, 11.9639708460923, 12.7399894953773, 11.1039329051223,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 10.8799371308504, 11.2339496349445, 9.76785687070542, 10.2366061420243,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 12.2796829311738, 12.2145485147061, 10.8626382875362, 10.6997615749098,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 11.1127818612008, 10.2044882008491, 9.55532315155379, 12.3878010722092,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 10.0883488632969, 10.2986692955371, 8.44723250957774, 10.0739800556359,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 10.3100606658507, 8.53507695750092, 6.80771701864661, 9.08112324755559,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 11.2007723665746, 5.36953957083154, 8.84464343581748, 9.1813883871468,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 12.6558138994376, 8.31935764167683, 12.6394465114412, 10.357071177282,
Sep 06 19:47:27 Ecologia docker-compose[233855]: r_1      | 8.109010197104, 9.10875078463295, 9.48079378704618, 10.1610827406104,
Lobz commented 1 week ago

Testei submeter um código com edit, e o resultado é que o container r abre um vim e fica esperando o input para sempre. Reiniciar o serviço resolve o problema.