Task fails to continue. A white screen appears instead.
Hi,
I'm having an issue with a sequence of tasks created on Jatos. A few weeks ago, my colleague created a sequence of tasks on Jatos (e.g., a digit span task and a go no-go task both written in jsPsych). The two versions of jsPsych are different though because the digit span task was written with an older version. However, until a couple of days ago, everything was running fine. Participants were able to access to the experiment online (from their smartphone with different browsers : Chrome, Safari) and complete both tasks.
However, we have been experiencing a problem now. When we try to run the experiment, I am able to start the first task (digit span), but it doesn't allow me to complete it. After a certain time the full screen becomes white and the results of the task are not recorded. Additionally, I am not able to continue with the second task in line (in this case the go no-go task).
What could the problem be? Is it possible that the old version of the jsPsych might be the issue? If so, why only now (and not 2 weeks ago)?
Eventually, does this mean that I have to re-write the whole task with a new version of jsPsych or is there any alternative solution?
Thank you,
Deni
Comments
Hi Deni,
If it worked before, it might work again. What changed in between, did you update anything? Which server are you using?
Also, it's good that you can reproduce the error. It makes troubleshooting possible. Can you open the console (under Developer tools in your browser) and see if you get any errors?
Elisa
Thanks Elisa for your prompt reply.
We did not update anything. We are having issues using Google Chrome Android.
The error is attached here:
Thanks
Just to clarify, the problem doesn't seem to be during the task per se. It seems to be between one task and the next one, the results are not recorded and participants cannot proceed to the following task.
Many thanks.
Hi Deni!
In the screenshot I can see that jatos.js cannot send the result data. It tries 5x and then gives up. That is strange since there are no other errors in the console (or are there?).
I have a couple of questions:
Can you please check in the Network tab of your Dev Tools what the HTTP return code of all the failed requests is?
Do you have an admin account on your JATOS? If yes, can you please have a look at the logs there (Admin -> logs), especially around the time when one of those failed result data sending is happening and look for errors or exceptions there?
Another thing that comes to my mind (although this would be weird), since this JATOS endpoint is the only one during study running that is using a HTTP PUT, is it possible that something somehow doesn't allow PUT requests to go through?
Best,
Kristian
Hi Kristian,
Thanks for your reply.
The error is 403.
Please see the attached file to answer your second question.
Many thanks
From you log I can see that you try to load the same component again although this is not allowed in your study properties:
13:24:16,094 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/startThis causes the study run to get finished:
13:24:16,117 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+%28ID%3A+229%29.+Study+%28ID%3A+195%29+is+finished.And subsequent sending of result data doesn't work anymore, because finished study runs do not accept new result data:
I can see those errors in your log "PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)".I assume there were other failed requests in the network tab of your browser's dev tools indicating the fail to reload the component.
Your course of action should be to figure out what is causing the reloading of the component in your study's code. There are jatos.js functions to control the study flow, e.g. to start another component jatos.startComponent, jatos.startComponentByPos, jatos.startComponentByTitle, jatos.startNextComponent, and jatos.startLastComponent. A good starting point is to find all occurrences of these functions.
I hope this helps.
Best,
Kristian
Many thanks for your help!
Everything is working properly now.
Best wishes
Denise
Hi Kristian,
Thanks for your reply. I'll answer your question point by point:
1) the code of all the failed requests is 430 (i.e. forbidden).
2) these are the errors we can see:
Line 183: 2025-01-16 13:22:38,572 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 185: 2025-01-16 13:22:38,824 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 187: 2025-01-16 13:22:38,864 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 190: 2025-01-16 13:22:42,964 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 192: 2025-01-16 13:22:43,515 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 194: 2025-01-16 13:22:43,528 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 196: 2025-01-16 13:22:45,697 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 198: 2025-01-16 13:22:45,698 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 200: 2025-01-16 13:24:11,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/resultData
Line 202: 2025-01-16 13:24:11,851 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/studySessionData
Line 204: 2025-01-16 13:24:11,909 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 206: 2025-01-16 13:24:12,218 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/initData
Line 208: 2025-01-16 13:24:12,269 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 211: 2025-01-16 13:24:16,094 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 213: 2025-01-16 13:24:16,117 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+%28ID%3A+229%29.+Study+%28ID%3A+195%29+is+finished.
Line 215: 2025-01-16 13:24:16,435 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 217: 2025-01-16 13:24:16,554 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 219: 2025-01-16 13:25:30,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 220: 2025-01-16 13:25:30,808 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 221: 2025-01-16 13:25:31,875 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 222: 2025-01-16 13:25:31,876 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 223: 2025-01-16 13:25:32,949 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 224: 2025-01-16 13:25:32,949 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 225: 2025-01-16 13:25:34,019 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 226: 2025-01-16 13:25:34,020 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 227: 2025-01-16 13:25:35,088 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 228: 2025-01-16 13:25:35,089 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 229: 2025-01-16 13:25:36,156 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 230: 2025-01-16 13:25:36,157 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 231: 2025-01-16 13:26:12,303 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 233: 2025-01-16 13:28:12,347 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 245: 2025-01-16 13:30:12,400 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 258: 2025-01-16 13:32:12,461 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 267: 2025-01-16 13:34:12,513 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 283: 2025-01-16 13:36:12,563 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
3) I don't know, but it would be weird given that it was working fine until a couple of weeks ago and the code has not been updated.
Many thanks for your help!
Hi Kristian,
Thanks for your reply. I'll answer your question point by point:
1) the code of all the failed requests is 430 (i.e. forbidden).
2) these are the errors we can see:
Line 183: 2025-01-16 13:22:38,572 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 185: 2025-01-16 13:22:38,824 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 187: 2025-01-16 13:22:38,864 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 190: 2025-01-16 13:22:42,964 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 192: 2025-01-16 13:22:43,515 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 194: 2025-01-16 13:22:43,528 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 196: 2025-01-16 13:22:45,697 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 198: 2025-01-16 13:22:45,698 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 200: 2025-01-16 13:24:11,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/resultData
Line 202: 2025-01-16 13:24:11,851 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/studySessionData
Line 204: 2025-01-16 13:24:11,909 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 206: 2025-01-16 13:24:12,218 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/initData
Line 208: 2025-01-16 13:24:12,269 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 211: 2025-01-16 13:24:16,094 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 213: 2025-01-16 13:24:16,117 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+%28ID%3A+229%29.+Study+%28ID%3A+195%29+is+finished.
Line 215: 2025-01-16 13:24:16,435 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 217: 2025-01-16 13:24:16,554 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 219: 2025-01-16 13:25:30,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 220: 2025-01-16 13:25:30,808 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 221: 2025-01-16 13:25:31,875 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 222: 2025-01-16 13:25:31,876 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 223: 2025-01-16 13:25:32,949 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 224: 2025-01-16 13:25:32,949 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 225: 2025-01-16 13:25:34,019 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 226: 2025-01-16 13:25:34,020 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 227: 2025-01-16 13:25:35,088 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 228: 2025-01-16 13:25:35,089 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 229: 2025-01-16 13:25:36,156 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 230: 2025-01-16 13:25:36,157 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 231: 2025-01-16 13:26:12,303 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 233: 2025-01-16 13:28:12,347 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 245: 2025-01-16 13:30:12,400 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 258: 2025-01-16 13:32:12,461 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 267: 2025-01-16 13:34:12,513 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 283: 2025-01-16 13:36:12,563 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
3) I don't know, but it would be weird given that it was working fine until a couple of weeks ago.
Hi Kristian,
Thanks for your reply. I'll answer your question point by point:
1) the code of all the failed requests is 430 (i.e. forbidden).
2) these are the errors we can see:
Line 183: 2025-01-16 13:22:38,572 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 185: 2025-01-16 13:22:38,824 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 187: 2025-01-16 13:22:38,864 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 190: 2025-01-16 13:22:42,964 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 192: 2025-01-16 13:22:43,515 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 194: 2025-01-16 13:22:43,528 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 196: 2025-01-16 13:22:45,697 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 198: 2025-01-16 13:22:45,698 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 200: 2025-01-16 13:24:11,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/resultData
Line 202: 2025-01-16 13:24:11,851 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/studySessionData
Line 204: 2025-01-16 13:24:11,909 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 206: 2025-01-16 13:24:12,218 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/initData
Line 208: 2025-01-16 13:24:12,269 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 211: 2025-01-16 13:24:16,094 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 213: 2025-01-16 13:24:16,117 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+%28ID%3A+229%29.+Study+%28ID%3A+195%29+is+finished.
Line 215: 2025-01-16 13:24:16,435 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 217: 2025-01-16 13:24:16,554 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 219: 2025-01-16 13:25:30,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 220: 2025-01-16 13:25:30,808 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 221: 2025-01-16 13:25:31,875 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 222: 2025-01-16 13:25:31,876 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 223: 2025-01-16 13:25:32,949 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 224: 2025-01-16 13:25:32,949 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 225: 2025-01-16 13:25:34,019 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 226: 2025-01-16 13:25:34,020 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 227: 2025-01-16 13:25:35,088 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 228: 2025-01-16 13:25:35,089 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 229: 2025-01-16 13:25:36,156 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 230: 2025-01-16 13:25:36,157 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 231: 2025-01-16 13:26:12,303 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 233: 2025-01-16 13:28:12,347 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 245: 2025-01-16 13:30:12,400 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 258: 2025-01-16 13:32:12,461 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 267: 2025-01-16 13:34:12,513 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 283: 2025-01-16 13:36:12,563 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
3) I don't know, but it would be weird given that it was working fine until a couple of weeks ago.
Hi Kristian,
Thanks for your reply. I'll answer your question point by point:
1) the code of all the failed requests is 430 (i.e. forbidden).
2) these are the logs there:
Line 183: 2025-01-16 13:22:38,572 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 185: 2025-01-16 13:22:38,824 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 187: 2025-01-16 13:22:38,864 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 190: 2025-01-16 13:22:42,964 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 192: 2025-01-16 13:22:43,515 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 194: 2025-01-16 13:22:43,528 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 196: 2025-01-16 13:22:45,697 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 198: 2025-01-16 13:22:45,698 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 200: 2025-01-16 13:24:11,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/resultData
Line 202: 2025-01-16 13:24:11,851 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/studySessionData
Line 204: 2025-01-16 13:24:11,909 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 206: 2025-01-16 13:24:12,218 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/initData
Line 208: 2025-01-16 13:24:12,269 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 211: 2025-01-16 13:24:16,094 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 213: 2025-01-16 13:24:16,117 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+%28ID%3A+229%29.+Study+%28ID%3A+195%29+is+finished.
Line 215: 2025-01-16 13:24:16,435 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 217: 2025-01-16 13:24:16,554 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 219: 2025-01-16 13:25:30,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 220: 2025-01-16 13:25:30,808 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 221: 2025-01-16 13:25:31,875 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 222: 2025-01-16 13:25:31,876 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 223: 2025-01-16 13:25:32,949 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 224: 2025-01-16 13:25:32,949 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 225: 2025-01-16 13:25:34,019 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 226: 2025-01-16 13:25:34,020 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 227: 2025-01-16 13:25:35,088 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 228: 2025-01-16 13:25:35,089 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 229: 2025-01-16 13:25:36,156 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 230: 2025-01-16 13:25:36,157 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 231: 2025-01-16 13:26:12,303 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 233: 2025-01-16 13:28:12,347 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 245: 2025-01-16 13:30:12,400 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 258: 2025-01-16 13:32:12,461 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 267: 2025-01-16 13:34:12,513 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 283: 2025-01-16 13:36:12,563 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
3) I don't know, but it would be weird given that it was working fine until a couple of weeks ago.
Hi Kristian,
Thanks for your reply. I'll answer your question point by point:
1) the code of all the failed requests is 430 (i.e. forbidden).
2) these are the errors we can see:
Line 183: 2025-01-16 13:22:38,572 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 185: 2025-01-16 13:22:38,824 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 187: 2025-01-16 13:22:38,864 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 190: 2025-01-16 13:22:42,964 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 192: 2025-01-16 13:22:43,515 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 194: 2025-01-16 13:22:43,528 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/start
Line 196: 2025-01-16 13:22:45,697 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 198: 2025-01-16 13:22:45,698 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/initData
Line 200: 2025-01-16 13:24:11,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/9b4d9f45-9ac3-40e8-8908-85d157144076/resultData
Line 202: 2025-01-16 13:24:11,851 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/studySessionData
Line 204: 2025-01-16 13:24:11,909 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 206: 2025-01-16 13:24:12,218 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/initData
Line 208: 2025-01-16 13:24:12,269 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 211: 2025-01-16 13:24:16,094 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/start
Line 213: 2025-01-16 13:24:16,117 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+%28ID%3A+229%29.+Study+%28ID%3A+195%29+is+finished.
Line 215: 2025-01-16 13:24:16,435 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 217: 2025-01-16 13:24:16,554 [INFO] - publix_access - GET /publix/e04515dd-d645-4288-a766-ba0262123665/end?successful=false&message=It%27s+not+allowed+to+reload+this+component+(ID:+229).+Study+(ID:+195)+is+finished.
Line 219: 2025-01-16 13:25:30,807 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 220: 2025-01-16 13:25:30,808 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 221: 2025-01-16 13:25:31,875 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 222: 2025-01-16 13:25:31,876 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 223: 2025-01-16 13:25:32,949 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 224: 2025-01-16 13:25:32,949 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 225: 2025-01-16 13:25:34,019 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 226: 2025-01-16 13:25:34,020 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 227: 2025-01-16 13:25:35,088 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 228: 2025-01-16 13:25:35,089 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 229: 2025-01-16 13:25:36,156 [INFO] - publix_access - PUT /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData
Line 230: 2025-01-16 13:25:36,157 [INFO] - g.ErrorHandler - PublixException during call /publix/e04515dd-d645-4288-a766-ba0262123665/8f0ed4b4-104d-4960-babb-d35b608b1539/resultData: Study run is already finished (study result 1336)
Line 231: 2025-01-16 13:26:12,303 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 233: 2025-01-16 13:28:12,347 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 245: 2025-01-16 13:30:12,400 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 258: 2025-01-16 13:32:12,461 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 267: 2025-01-16 13:34:12,513 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
Line 283: 2025-01-16 13:36:12,563 [INFO] - publix_access - POST /publix/e04515dd-d645-4288-a766-ba0262123665/heartbeat
3) I don't know, but it would be weird given that it was working fine until a couple of weeks ago.