Hi guys,
Thanks for the great job you do, i submit an issue :
2017-11-24 16:35:29.003 ----- DEBUG ----- loginCheck : current db version = 'V6.4.4'
2017-11-24 16:35:29.004 ----- DEBUG ----- User->authenticate('')
2017-11-24 16:35:29.006 ----- DEBUG ----- User->authenticate : sha256 encryption
2017-11-24 16:35:29.006 ----- DEBUG ----- User->authenticate : Successfull login
2017-11-24 16:35:29.065 ===== TRACE ===== NEW CONNECTED USER 'mgest'
2017-11-24 16:39:52.550 ** ERROR ** [V6.4.4] Exception-[HY000] SQLSTATE[HY000]: General error: 1205 Lock wait timeout exceeded; try restarting transaction
2017-11-24 16:39:52.566 ** ERROR ** [V6.4.4] For query : update kpivalue set kpiValue='0.11875' where id=3
2017-11-24 16:39:52.566 ** ERROR ** [V6.4.4] Strack trace :
2017-11-24 16:39:52.567 ** ERROR ** [V6.4.4] #0 Sql->query called at [/home/decideomuw/www/model/persistence/SqlElement.php:1408]
2017-11-24 16:39:52.567 ** ERROR ** [V6.4.4] #1 SqlElement->updateSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:923]
2017-11-24 16:39:52.567 ** ERROR ** [V6.4.4] #2 SqlElement->saveSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:619]
2017-11-24 16:39:52.567 ** ERROR ** [V6.4.4] #3 SqlElement->save called at [/home/decideomuw/www/model/KpiValue.php:74]
2017-11-24 16:39:52.568 ** ERROR ** [V6.4.4] #4 KpiValue->save called at [/home/decideomuw/www/model/KpiValue.php:120]
2017-11-24 16:39:52.568 ** ERROR ** [V6.4.4] #5 KpiValue->calculateKpi called at [/home/decideomuw/www/model/ProjectPlanningElementMain.php:204]
2017-11-24 16:39:52.568 ** ERROR ** [V6.4.4] #6 ProjectPlanningElementMain->save called at [/home/decideomuw/www/model/ProjectPlanningElementMain.php:279]
2017-11-24 16:39:52.569 ** ERROR ** [V6.4.4] #7 ProjectPlanningElementMain->updateSynthesisProject called at [/home/decideomuw/www/model/PlanningElement.php:773]
2017-11-24 16:39:52.569 ** ERROR ** [V6.4.4] #8 PlanningElement->updateSynthesis called at [/home/decideomuw/www/model/WorkElementMain.php:348]
2017-11-24 16:39:52.569 ** ERROR ** [V6.4.4] #9 WorkElementMain->save called at [/home/decideomuw/www/model/persistence/SqlElement.php:1529]
2017-11-24 16:39:52.570 ** ERROR ** [V6.4.4] #10 SqlElement->saveDependantObjects called at [/home/decideomuw/www/model/persistence/SqlElement.php:1467]
2017-11-24 16:39:52.570 ** ERROR ** [V6.4.4] #11 SqlElement->updateSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:923]
2017-11-24 16:39:52.570 ** ERROR ** [V6.4.4] #12 SqlElement->saveSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:754]
2017-11-24 16:39:52.571 ** ERROR ** [V6.4.4] #13 SqlElement->saveForced called at [/home/decideomuw/www/model/Note.php:90]
2017-11-24 16:39:52.571 ** ERROR ** [V6.4.4] #14 Note->save called at [/home/decideomuw/www/tool/saveNote.php:89]
2017-11-24 16:40:43.577 ** ERROR ** [V6.4.4] Exception-[HY000] SQLSTATE[HY000]: General error: 1205 Lock wait timeout exceeded; try restarting transaction
2017-11-24 16:40:43.592 ** ERROR ** [V6.4.4] For query : delete from kpihistory where idKpiDefinition=1 and refType='Project' and refId=13 and kpiDate='2017-11-24'
2017-11-24 16:40:43.593 ** ERROR ** [V6.4.4] Strack trace :
2017-11-24 16:40:43.593 ** ERROR ** [V6.4.4] #0 Sql->query called at [/home/decideomuw/www/model/persistence/SqlElement.php:1731]
2017-11-24 16:40:43.593 ** ERROR ** [V6.4.4] #1 SqlElement->purgeSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:775]
2017-11-24 16:40:43.594 ** ERROR ** [V6.4.4] #2 SqlElement->purge called at [/home/decideomuw/www/model/KpiValue.php:84]
2017-11-24 16:40:43.594 ** ERROR ** [V6.4.4] #3 KpiValue->storeHistory called at [/home/decideomuw/www/model/KpiValue.php:76]
2017-11-24 16:40:43.594 ** ERROR ** [V6.4.4] #4 KpiValue->save called at [/home/decideomuw/www/model/KpiValue.php:120]
2017-11-24 16:40:43.595 ** ERROR ** [V6.4.4] #5 KpiValue->calculateKpi called at [/home/decideomuw/www/model/ProjectPlanningElementMain.php:204]
2017-11-24 16:40:43.595 ** ERROR ** [V6.4.4] #6 ProjectPlanningElementMain->save called at [/home/decideomuw/www/model/ProjectPlanningElementMain.php:279]
2017-11-24 16:40:43.595 ** ERROR ** [V6.4.4] #7 ProjectPlanningElementMain->updateSynthesisProject called at [/home/decideomuw/www/model/PlanningElement.php:773]
2017-11-24 16:40:43.596 ** ERROR ** [V6.4.4] #8 PlanningElement->updateSynthesis called at [/home/decideomuw/www/model/WorkElementMain.php:348]
2017-11-24 16:40:43.596 ** ERROR ** [V6.4.4] #9 WorkElementMain->save called at [/home/decideomuw/www/model/persistence/SqlElement.php:1529]
2017-11-24 16:40:43.596 ** ERROR ** [V6.4.4] #10 SqlElement->saveDependantObjects called at [/home/decideomuw/www/model/persistence/SqlElement.php:1467]
2017-11-24 16:40:43.596 ** ERROR ** [V6.4.4] #11 SqlElement->updateSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:923]
2017-11-24 16:40:43.597 ** ERROR ** [V6.4.4] #12 SqlElement->saveSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:754]
2017-11-24 16:40:43.597 ** ERROR ** [V6.4.4] #13 SqlElement->saveForced called at [/home/decideomuw/www/model/Note.php:90]
2017-11-24 16:40:43.597 ** ERROR ** [V6.4.4] #14 Note->save called at [/home/decideomuw/www/tool/saveNote.php:89]
2017-11-24 16:41:00.157 ** ERROR ** [V6.4.4] Error sending mail
2017-11-24 16:41:00.188 ** ERROR ** [V6.4.4] SMTP Server : SSL0.OVH.NET
2017-11-24 16:41:00.189 ** ERROR ** [V6.4.4] SMTP Port : 465
2017-11-24 16:41:00.189 ** ERROR ** [V6.4.4] Mail stored in Database : #1136
2017-11-24 16:41:00.189 ** ERROR ** [V6.4.4] PHPMail error : SMTP Error: The following recipients failed: phprevost@gmail.com: : Recipient address rejected: You have exceeded the limit of 400 messages per hour and per IP address. Please, re-try later.
fandry@gmail.com: : Recipient address rejected: You have exceeded the limit of 400 messages per hour and per IP address. Please, re-try later.
Can you please have a look on it.
Thanks in advance
Pierre
What were you doing (which operation) at 16:39.?
How many users were connected to tha application (you can check on audit)
Hi Thanks,
1/ As I saw they try to create a ticket for a project
2/ They have 14 connexions during the day and at least 13 users
Thanks for your time
It seems there is lock of table, possibly deadlock.
Did it occur only once or is it produced often ?
Hi,
Yes, I have it again :
2017-12-13 11:35:52.119 ..... SCRIPT .... 185.12.96.5 getProfile(objectOrIdProject=Audit #1003)
2017-12-13 11:36:03.565 ..... SCRIPT .... 185.12.96.5 Page=checkAlertToDisplay.php
2017-12-13 11:36:03.591 ..... SCRIPT .... 185.12.96.5 refreshParameters()
2017-12-13 11:36:03.618 ..... SCRIPT .... 185.12.96.5 getProfile(objectOrIdProject=Audit #1030)
2017-12-13 11:36:05.703 ** ERROR ** [V6.4.4] Exception-[HY000] SQLSTATE[HY000]: General error: 1205 Lock wait timeout exceeded; try restarting transaction
2017-12-13 11:36:05.704 ** ERROR ** [V6.4.4] For query : delete from kpihistory where idKpiDefinition=1 and refType='Project' and refId=141 and kpiDate='2017-12-13'
2017-12-13 11:36:05.704 ** ERROR ** [V6.4.4] Strack trace :
2017-12-13 11:36:05.704 ** ERROR ** [V6.4.4] #0 Sql->query called at [/home/decideomuw/www/model/persistence/SqlElement.php:1731]
2017-12-13 11:36:05.704 ** ERROR ** [V6.4.4] #1 SqlElement->purgeSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:775]
2017-12-13 11:36:05.705 ** ERROR ** [V6.4.4] #2 SqlElement->purge called at [/home/decideomuw/www/model/KpiValue.php:84]
2017-12-13 11:36:05.705 ** ERROR ** [V6.4.4] #3 KpiValue->storeHistory called at [/home/decideomuw/www/model/KpiValue.php:76]
2017-12-13 11:36:05.705 ** ERROR ** [V6.4.4] #4 KpiValue->save called at [/home/decideomuw/www/model/KpiValue.php:120]
2017-12-13 11:36:05.706 ** ERROR ** [V6.4.4] #5 KpiValue->calculateKpi called at [/home/decideomuw/www/model/ProjectPlanningElementMain.php:204]
2017-12-13 11:36:05.706 ** ERROR ** [V6.4.4] #6 ProjectPlanningElementMain->save called at [/home/decideomuw/www/model/ProjectPlanningElementMain.php:279]
2017-12-13 11:36:05.706 ** ERROR ** [V6.4.4] #7 ProjectPlanningElementMain->updateSynthesisProject called at [/home/decideomuw/www/model/PlanningElement.php:773]
2017-12-13 11:36:05.707 ** ERROR ** [V6.4.4] #8 PlanningElement->updateSynthesis called at [/home/decideomuw/www/model/WorkElementMain.php:348]
2017-12-13 11:36:05.707 ** ERROR ** [V6.4.4] #9 WorkElementMain->save called at [/home/decideomuw/www/model/persistence/SqlElement.php:1529]
2017-12-13 11:36:05.707 ** ERROR ** [V6.4.4] #10 SqlElement->saveDependantObjects called at [/home/decideomuw/www/model/persistence/SqlElement.php:1467]
2017-12-13 11:36:05.708 ** ERROR ** [V6.4.4] #11 SqlElement->updateSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:923]
2017-12-13 11:36:05.708 ** ERROR ** [V6.4.4] #12 SqlElement->saveSqlElement called at [/home/decideomuw/www/model/persistence/SqlElement.php:619]
2017-12-13 11:36:05.708 ** ERROR ** [V6.4.4] #13 SqlElement->save called at [/home/decideomuw/www/model/TicketMain.php:390]
2017-12-13 11:36:05.709 ** ERROR ** [V6.4.4] #14 TicketMain->save called at [/home/decideomuw/www/tool/saveObject.php:78]
2017-12-13 11:36:05.710 ..... SCRIPT .... 185.12.96.5 getProfile(objectOrIdProject=KpiHistory #)
2017-12-13 11:36:05.710 ..... SCRIPT .... 185.12.96.5 securityGetAccessRightYesNo ( menuName=menuKpiHistory, accessType=create, obj=KpiHistory #, user=)
2017-12-13 11:36:05.711 ..... SCRIPT .... 185.12.96.5 securityGetAccessRight(menuName=menuKpiHistory, accessType=create, obj=KpiHistory #, user=User #7)
2017-12-13 11:36:05.711 ..... SCRIPT .... 185.12.96.5 getAccessControlRights(obj=KpiHistory #)
2017-12-13 11:36:05.712 ..... SCRIPT .... 185.12.96.5 getProfile(objectOrIdProject=KpiHistory #)
2017-12-13 11:36:45.469 ..... SCRIPT .... 185.12.96.5 Page=checkAlertToDisplay.php
2017-12-13 11:36:45.506 ..... SCRIPT .... 185.12.96.5 getProfile(objectOrIdProject=Audit #1031)
2017-12-13 11:36:49.316 ** ERROR ** [V6.4.4] Error sending mail
2017-12-13 11:36:49.339 ** ERROR ** [V6.4.4] SMTP Server : SSL0.OVH.NET
2017-12-13 11:36:49.339 ** ERROR ** [V6.4.4] SMTP Port : 465
2017-12-13 11:36:49.340 ** ERROR ** [V6.4.4] Mail stored in Database : #1285
2017-12-13 11:36:49.340 ** ERROR ** [V6.4.4] PHPMail error : SMTP Error: The following recipients failed: fandry@gmail.fr: : Recipient address rejected: You have exceeded the limit of 400 messages per hour and per IP address. Please, re-try later.
phprevost@gmail.fr: : Recipient address rejected: You have exceeded the limit of 400 messages per hour and per IP address. Please, re-try later.
cbonnand@gmail.fr: : Recipient address rejected: You have exceeded the limit of 400 messages per hour and per IP address. Please, re-try later.
2017-12-13 11:36:49.340 ** ERROR ** [V6.4.4] PHPMail debug : 2017-12-13 10:34:13 CLIENT -> SERVER: EHLO www.decideom.net
2017-12-13 10:34:13 CLIENT -> SERVER: AUTH LOGIN
2017-12-13 10:34:13 CLIENT -> SERVER: c3VwcG9ydEBkZWNpZGVvbS5uZXQ=
2017-12-13 10:34:13 CLIENT -> SERVER: ZGVjaWRlb20yMDE3
2017-12-13 10:34:13 CLIENT -> SERVER: MAIL FROM:
2017-12-13 10:34:13 CLIENT -> SERVER: RCPT TO:
It seems you have issue with your SMTP server.
This can be source of issue because email sending is not asynchonous, so it's it the flow of treatment.
This means that if your SMTP server takes long to respond, items are locked for a long period, possibly leading to error you face.
Try and change your SMTP server, I guess it will fix the issue.
(we pallned to adapt asynchronous email sendiong, but its' not for tomorrow)
Hi,
Thanks for the answer, I changed the way of mail is send and it's resolved the issue.
For OVH I use the PHPmail function.