1. Accueil
  2. Question et réponse
  3. Umbraco 7.6.0 - Le site ne répond plus tous les matins, puis revient

Umbraco 7.6.0 - Le site ne répond plus tous les matins, puis revient

2017-08-17 1 views
0

Nous avons un site de production sous Umbraco 7.6.0. Chaque matin, nous recevons une alerte de surveillance en raison de 30s + temps de réponse sur la page d'accueil, et environ 10-15 minutes plus tard, le problème se résout. La nuit dernière, nous avons changé la verbosité du journal en DEBUG, et nous sommes toujours incapables d'identifier la cause du problème ce matin. Chaque fois que cette question a eu lieu, nous voyons ce que je crois être des effets de la question - la Keep Alive et planifiées Publier des tâches ne (date probable sortie):Umbraco 7.6.0 - Le site ne répond plus tous les matins, puis revient

ERROR Umbraco.Web.Scheduling.ScheduledPublishing - Failed (at "https://www.[domainredacted].com:443/umbraco"). 
System.Threading.Tasks.TaskCanceledException: A task was canceled. 
    at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task) 
    at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task) 
    at Umbraco.Web.Scheduling.ScheduledPublishing.<PerformRunAsync>d__7.MoveNext()

enter image description here

Parce que la CPU et L'utilisation de la mémoire sur le plan Azure App Service pendant la panne a été stable, ce qui me porte à croire qu'il y a une sorte d'impasse - et cela ne se produit qu'une fois par jour. Malheureusement, les journaux DEBUG ne sont pas utiles non plus. J'essaie de chercher une tâche/procédure qui commence mais ne finit jamais. Je vois une publication planifiée qui a pris 100 secondes (ce qui est assez long), mais encore une fois cela pourrait juste être un effet causé par le problème, et pas nécessairement la cause elle-même. Quelqu'un a-t-il des idées sur ce que pourrait être le problème et/ou comment mieux enquêter?

Voici un journal avec expurgée informations sur les projets sensibles:

2017-08-17 13:14:47,066 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: Begin finders 
2017-08-17 13:14:47,066 [P4824/D11/T56] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,066 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - [route redacted] 
2017-08-17 13:14:47,082 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - Got content, id=39911 
2017-08-17 13:14:47,082 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: End finders, no document was found (took 8ms) 
2017-08-17 13:14:47,082 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandlePublishedContent: Begin 
2017-08-17 13:14:47,082 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - EnsurePublishedContentAccess: Page is not protected 
2017-08-17 13:14:47,082 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandlePublishedContent: End 
2017-08-17 13:14:47,082 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Look for template id=1191 
2017-08-17 13:14:47,098 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Got template id=1191 alias="Property" 
2017-08-17 13:14:47,098 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Running with template id=1191 alias="Property" 
2017-08-17 13:14:47,098 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandleWildcardDomains: Path="-1,1054,1194,39911" 
2017-08-17 13:14:47,098 [P4824/D11/T71] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandleWildcardDomains: No match. 
2017-08-17 13:14:47,098 [P4824/D11/T71] DEBUG Umbraco.Web.UmbracoModule - Response status: Redirect=none, Is404=false, StatusCode=0 
2017-08-17 13:14:47,238 [P4824/D11/T30] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,285 [P4824/D11/T60] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,301 [P4824/D11/T81] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,332 [P4824/D11/T56] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,332 [P4824/D11/T10] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,379 [P4824/D11/T71] DEBUG Umbraco.Web.UmbracoModule - Total milliseconds for umbraco request to process: 312.4882 
2017-08-17 13:14:47,394 [P4824/D11/T23] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,551 [P4824/D11/T81] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,598 [P4824/D11/T58] DEBUG Umbraco.Core.Sync.ServerMessengerBase - Invoking refresher Umbraco.Web.Cache.UnpublishedPageCacheRefresher on local server for message type RefreshByInstance 
2017-08-17 13:14:47,629 [P4824/D11/T58] DEBUG UmbracoExamine.DataServices.UmbracoLogService - ReIndexNode with type: content, Provider=InternalIndexer, NodeId=40744 
2017-08-17 13:14:47,629 [P4824/D11/T58] DEBUG UmbracoExamine.DataServices.UmbracoLogService - AddSingleNodeToIndex with type: content, Provider=InternalIndexer, NodeId=40744 
2017-08-17 13:14:47,738 [P4824/D11/T10] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,738 [P4824/D11/T10] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:47,816 [P4824/D11/T58] DEBUG Umbraco.Core.Sync.ServerMessengerBase - Invoking refresher Umbraco.Web.Cache.PageCacheRefresher on local server for message type RefreshByInstance 
2017-08-17 13:14:47,879 [P4824/D11/T71] DEBUG UmbracoExamine.DataServices.UmbracoLogService - Index created for node 40744, Provider=InternalIndexer, NodeId=40744 
2017-08-17 13:14:48,160 [P4824/D11/T58] DEBUG UmbracoExamine.DataServices.UmbracoLogService - ReIndexNode with type: content, Provider=InternalIndexer, NodeId=40744 
2017-08-17 13:14:48,160 [P4824/D11/T58] DEBUG UmbracoExamine.DataServices.UmbracoLogService - AddSingleNodeToIndex with type: content, Provider=InternalIndexer, NodeId=40744 
2017-08-17 13:14:48,160 [P4824/D11/T58] DEBUG UmbracoExamine.DataServices.UmbracoLogService - ReIndexNode with type: content, Provider=ExternalIndexer, NodeId=40744 
2017-08-17 13:14:48,160 [P4824/D11/T58] DEBUG UmbracoExamine.DataServices.UmbracoLogService - AddSingleNodeToIndex with type: content, Provider=ExternalIndexer, NodeId=40744 
2017-08-17 13:14:48,160 [P4824/D11/T23] DEBUG UmbracoExamine.DataServices.UmbracoLogService - Index created for node 40744, Provider=InternalIndexer, NodeId=40744 
2017-08-17 13:14:48,207 [P4824/D11/T58] DEBUG Umbraco.Web.PublishedCache.XmlPublishedCache.XmlCacheFilePersister - Touched, was idle, start and save in 4000ms. 
2017-08-17 13:14:48,223 [P4824/D11/T58] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Uri="[url redacted]" 
2017-08-17 13:14:48,223 [P4824/D11/T58] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Matches no domain 
2017-08-17 13:14:48,223 [P4824/D11/T58] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Culture="en-US" 
2017-08-17 13:14:48,223 [P4824/D11/T58] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: Begin finders 
2017-08-17 13:14:48,223 [P4824/D11/T58] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - [route redacted] 
2017-08-17 13:14:48,238 [P4824/D11/T58] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - Got content, id=40744 
2017-08-17 13:14:48,238 [P4824/D11/T58] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: End finders, no document was found (took 9ms) 
2017-08-17 13:14:48,285 [P4824/D11/T61] DEBUG UmbracoExamine.DataServices.UmbracoLogService - Index created for node 40744, Provider=ExternalIndexer, NodeId=40744 
2017-08-17 13:14:48,363 [P4824/D11/T15] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:48,379 [P4824/D11/T60] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:48,816 [P4824/D11/T71] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:49,332 [P4824/D11/T81] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:49,504 [P4824/D11/T81] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:49,848 [P4824/D11/T23] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:49,894 [P4824/D11/T10] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:51,316 [P4824/D11/T68] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:51,316 [P4824/D11/T68] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Syncing from database... 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Complete (took 29ms) 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Uri="[url redacted]" 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Matches no domain 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Culture="en-US" 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContentAndTemplate: Path="/" 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: Begin finders 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - [route redacted] 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - Got content, id=1054 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: End finders, no document was found (took 3ms) 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandlePublishedContent: Begin 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - EnsurePublishedContentAccess: Page is not protected 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandlePublishedContent: End 
2017-08-17 13:14:51,348 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Look for template id=1048 
2017-08-17 13:14:51,363 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Got template id=1048 alias="Homepage" 
2017-08-17 13:14:51,363 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Running with template id=1048 alias="Homepage" 
2017-08-17 13:14:51,363 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandleWildcardDomains: Path="-1,1054" 
2017-08-17 13:14:51,363 [P4824/D11/T68] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandleWildcardDomains: No match. 
2017-08-17 13:14:51,363 [P4824/D11/T68] DEBUG Umbraco.Web.UmbracoModule - Response status: Redirect=none, Is404=false, StatusCode=0 
2017-08-17 13:14:51,426 [P4824/D11/T68] DEBUG Umbraco.Web.UmbracoModule - Total milliseconds for umbraco request to process: 109.3749 
2017-08-17 13:14:52,223 [P4824/D11/T65] DEBUG Umbraco.Web.PublishedCache.XmlPublishedCache.XmlCacheFilePersister - Timer: release. 
2017-08-17 13:14:52,223 [P4824/D11/T65] DEBUG Umbraco.Web.PublishedCache.XmlPublishedCache.XmlCacheFilePersister - Run now (sync). 
2017-08-17 13:14:52,223 [P4824/D11/T65] INFO umbraco.content - Save Xml to file... 
2017-08-17 13:14:53,100 [P4824/D11/T10] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:53,631 [P4824/D11/T65] INFO umbraco.content - Saved Xml to file. 
2017-08-17 13:14:54,563 [P4824/D11/T60] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:56,003 [P4824/D11/T71] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:14:59,953 [P4824/D11/T61] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks executing 
2017-08-17 13:14:59,953 [P4824/D11/T61] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks complete (took 0ms) 
2017-08-17 13:14:59,953 [P4824/D11/T61] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledTasks] Task added Umbraco.Web.Scheduling.ScheduledTasks 
2017-08-17 13:15:01,940 [P4824/D11/T60] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:01,940 [P4824/D11/T60] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Syncing from database... 
2017-08-17 13:15:01,940 [P4824/D11/T60] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Complete (took 12ms) 
2017-08-17 13:15:11,904 [P4824/D11/T56] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:12,007 [P4824/D11/T30] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:12,069 [P4824/D11/T61] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:12,413 [P4824/D11/T23] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:13,317 [P4824/D11/T15] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:15,133 [P4824/D11/T68] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:24,516 [P4824/D11/T15] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:24,532 [P4824/D11/T15] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Syncing from database... 
2017-08-17 13:15:24,532 [P4824/D11/T15] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Complete (took 11ms) 
2017-08-17 13:15:24,532 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Uri="[url redacted]" 
2017-08-17 13:15:24,532 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Matches no domain 
2017-08-17 13:15:24,532 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Culture="en-US" 
2017-08-17 13:15:24,532 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContentAndTemplate: Path="[path redacted]" 
2017-08-17 13:15:24,532 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: Begin finders 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - [route redacted] 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - Got content, id=39911 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: End finders, no document was found (took 7ms) 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandlePublishedContent: Begin 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - EnsurePublishedContentAccess: Page is not protected 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandlePublishedContent: End 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Look for template id=1191 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Got template id=1191 alias="Property" 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Running with template id=1191 alias="Property" 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandleWildcardDomains: Path="-1,1054,1194,39911" 
2017-08-17 13:15:24,547 [P4824/D11/T15] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandleWildcardDomains: No match. 
2017-08-17 13:15:24,563 [P4824/D11/T15] DEBUG Umbraco.Web.UmbracoModule - Response status: Redirect=none, Is404=false, StatusCode=0 
2017-08-17 13:15:24,625 [P4824/D11/T15] DEBUG Umbraco.Web.UmbracoModule - Total milliseconds for umbraco request to process: 93.7463 
2017-08-17 13:15:24,672 [P4824/D11/T56] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:24,844 [P4824/D11/T81] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:24,860 [P4824/D11/T65] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [Umbraco.Web.Scheduling.IBackgroundTask] Task added Umbraco.Web.Strategies.ServerRegistrationEventHandler+TouchServerTask 
2017-08-17 13:15:27,042 [P4824/D11/T30] DEBUG Umbraco.Web.Scheduling.ScheduledPublishing - Scheduled publishing executing @ [url redacted] 
2017-08-17 13:15:27,542 [P4824/D11/T15] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:27,542 [P4824/D11/T58] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:30,562 [P4824/D11/T56] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:31,570 [P4824/D11/T68] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:31,570 [P4824/D11/T30] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:31,570 [P4824/D11/T68] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Syncing from database... 
2017-08-17 13:15:31,586 [P4824/D11/T68] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Complete (took 10ms) 
2017-08-17 13:15:44,659 [P4824/D11/T23] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:44,659 [P4824/D11/T23] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Syncing from database... 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Core.Sync.DatabaseServerMessenger - Complete (took 10ms) 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Uri="[url redacted]" 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Matches no domain 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindDomain: Culture="en-US" 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContentAndTemplate: Path="[path redacted]" 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: Begin finders 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - [route redacted] 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.ContentFinderByNiceUrl - Got content, id=39911 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindPublishedContent: End finders, no document was found (took 3ms) 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandlePublishedContent: Begin 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - EnsurePublishedContentAccess: Page is not protected 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandlePublishedContent: End 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Look for template id=1191 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Got template id=1191 alias="Property" 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - FindTemplate: Running with template id=1191 alias="Property" 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandleWildcardDomains: Path="-1,1054,1194,39911" 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.Routing.PublishedContentRequestEngine - HandleWildcardDomains: No match. 
2017-08-17 13:15:44,674 [P4824/D11/T23] DEBUG Umbraco.Web.UmbracoModule - Response status: Redirect=none, Is404=false, StatusCode=0 
2017-08-17 13:15:44,754 [P4824/D11/T23] DEBUG Umbraco.Web.UmbracoModule - Total milliseconds for umbraco request to process: 95.139 
2017-08-17 13:15:47,585 [P4824/D11/T60] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:47,960 [P4824/D11/T30] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:48,006 [P4824/D11/T15] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:48,073 [P4824/D11/T56] DEBUG Umbraco.Web.UmbracoModule - Begin request: [url redacted] 
2017-08-17 13:15:59,958 [P4824/D11/T60] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks executing 
2017-08-17 13:15:59,958 [P4824/D11/T60] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks complete (took 0ms) 
2017-08-17 13:15:59,958 [P4824/D11/T60] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledTasks] Task added Umbraco.Web.Scheduling.ScheduledTasks 
2017-08-17 13:16:24,966 [P4824/D11/T56] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [Umbraco.Web.Scheduling.IBackgroundTask] Task added Umbraco.Web.Strategies.ServerRegistrationEventHandler+TouchServerTask 
2017-08-17 13:16:59,968 [P4824/D11/T56] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks executing 
2017-08-17 13:16:59,968 [P4824/D11/T56] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks complete (took 0ms) 
2017-08-17 13:16:59,968 [P4824/D11/T56] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledTasks] Task added Umbraco.Web.Scheduling.ScheduledTasks 
2017-08-17 13:17:07,056 [P4824/D11/T15] ERROR Umbraco.Web.Scheduling.ScheduledPublishing - Failed (at "[url redacted]"). 
System.Threading.Tasks.TaskCanceledException: A task was canceled. 
    at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task) 
    at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task) 
    at Umbraco.Web.Scheduling.ScheduledPublishing.<PerformRunAsync>d__7.MoveNext() 
2017-08-17 13:17:07,056 [P4824/D11/T15] DEBUG Umbraco.Web.Scheduling.ScheduledPublishing - Scheduled publishing complete (took 100027ms) 
2017-08-17 13:17:07,056 [P4824/D11/T15] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledPublishing] Task added Umbraco.Web.Scheduling.ScheduledPublishing 
2017-08-17 13:17:25,037 [P4824/D11/T56] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [Umbraco.Web.Scheduling.IBackgroundTask] Task added Umbraco.Web.Strategies.ServerRegistrationEventHandler+TouchServerTask 
2017-08-17 13:17:59,197 [P4824/D11/T15] DEBUG Umbraco.Web.Scheduling.KeepAlive - Keep alive executing 
2017-08-17 13:17:59,973 [P4824/D11/T61] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks executing 
2017-08-17 13:17:59,973 [P4824/D11/T61] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks complete (took 0ms) 
2017-08-17 13:17:59,973 [P4824/D11/T61] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledTasks] Task added Umbraco.Web.Scheduling.ScheduledTasks 
2017-08-17 13:18:07,064 [P4824/D11/T23] DEBUG Umbraco.Web.Scheduling.ScheduledPublishing - Scheduled publishing executing @ [url redacted] 
2017-08-17 13:18:25,077 [P4824/D11/T60] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [Umbraco.Web.Scheduling.IBackgroundTask] Task added Umbraco.Web.Strategies.ServerRegistrationEventHandler+TouchServerTask 
2017-08-17 13:18:59,982 [P4824/D11/T56] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks executing 
2017-08-17 13:18:59,982 [P4824/D11/T56] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks complete (took 0ms) 
2017-08-17 13:18:59,982 [P4824/D11/T56] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledTasks] Task added Umbraco.Web.Scheduling.ScheduledTasks 
2017-08-17 13:19:25,184 [P4824/D11/T60] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [Umbraco.Web.Scheduling.IBackgroundTask] Task added Umbraco.Web.Strategies.ServerRegistrationEventHandler+TouchServerTask 
2017-08-17 13:19:39,208 [P4824/D11/T65] ERROR Umbraco.Web.Scheduling.KeepAlive - Failed (at "[url redacted]"). 
System.Threading.Tasks.TaskCanceledException: A task was canceled. 
    at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task) 
    at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task) 
    at Umbraco.Web.Scheduling.KeepAlive.<PerformRunAsync>d__4.MoveNext() 
2017-08-17 13:19:39,208 [P4824/D11/T65] DEBUG Umbraco.Web.Scheduling.KeepAlive - Keep alive complete (took 100016ms) 
2017-08-17 13:19:39,208 [P4824/D11/T65] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [KeepAlive] Task added Umbraco.Web.Scheduling.KeepAlive 
2017-08-17 13:19:47,085 [P4824/D11/T61] ERROR Umbraco.Web.Scheduling.ScheduledPublishing - Failed (at "[url redacted]"). 
System.Threading.Tasks.TaskCanceledException: A task was canceled. 
    at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess(Task task) 
    at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task) 
    at Umbraco.Web.Scheduling.ScheduledPublishing.<PerformRunAsync>d__7.MoveNext() 
2017-08-17 13:19:47,085 [P4824/D11/T61] DEBUG Umbraco.Web.Scheduling.ScheduledPublishing - Scheduled publishing complete (took 100023ms) 
2017-08-17 13:19:47,085 [P4824/D11/T61] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledPublishing] Task added Umbraco.Web.Scheduling.ScheduledPublishing 
2017-08-17 13:19:59,992 [P4824/D11/T15] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks executing 
2017-08-17 13:19:59,992 [P4824/D11/T15] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks complete (took 0ms) 
2017-08-17 13:19:59,992 [P4824/D11/T15] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledTasks] Task added Umbraco.Web.Scheduling.ScheduledTasks 
2017-08-17 13:20:25,261 [P4824/D11/T60] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [Umbraco.Web.Scheduling.IBackgroundTask] Task added Umbraco.Web.Strategies.ServerRegistrationEventHandler+TouchServerTask 
2017-08-17 13:20:47,105 [P4824/D11/T23] DEBUG Umbraco.Web.Scheduling.ScheduledPublishing - Scheduled publishing executing @ [url redacted] 
2017-08-17 13:20:54,710 [P4824/D11/T75] DEBUG Umbraco.Web.Scheduling.ScheduledPublishing - Scheduled publishing complete (took 7608ms) 
2017-08-17 13:20:54,710 [P4824/D11/T75] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledPublishing] Task added Umbraco.Web.Scheduling.ScheduledPublishing 
2017-08-17 13:21:00,012 [P4824/D11/T23] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks executing 
2017-08-17 13:21:00,012 [P4824/D11/T23] DEBUG Umbraco.Web.Scheduling.ScheduledTasks - Scheduled tasks complete (took 0ms) 
2017-08-17 13:21:00,012 [P4824/D11/T23] DEBUG Umbraco.Web.Scheduling.BackgroundTaskRunner - [ScheduledTasks] Task added Umbraco.Web.Scheduling.ScheduledTasks

Source

2017-08-17 Keith

+0

Juste une supposition, mais peut-être IIS recycle le site et il faut un certain temps pour démarrer à nouveau? Consultez cette question pour voir à propos de la désactivation des redémarrages automatiques: https://stackoverflow.com/q/3156925/2963111 – Harvey

+0

Vous pouvez également activer Request Monitor dans IIS. Il vous permet de voir les demandes Web actuelles faites à votre application, avec une quantité de temps pour laquelle la demande a été traitée. Cela peut être très utile: https://stackoverflow.com/q/15621509/2963111 – Harvey

+0

@Harvey C'est une raison assez courante pour voir cela, mais ce n'est pas le cas dans le scénario ci-dessus. – Keith

Répondre

0

S'il est hébergé sur une application Azure, il est susceptible d'être un mouvement App démarrage/App. À moins que votre site ne soit assez bien optimisé, vous pouvez parfois voir un démarrage assez lent sur Azure Apps, j'ai vu plus de 20 minutes sur des sites particulièrement mal optimisés.

Le principal responsable est le fichier IO lors du démarrage de l'application, je pense. Le site est-il assez grand? Aussi a-t-il beaucoup d'index Examiner personnalisés?

Il y a quelques conseils utiles pour améliorer la performance sur Azure ici: https://cultiv.nl/blog/making-sure-your-umbraco-site-performs-on-azure/

Source

2017-09-07 09:28:11 Tim

 Questions connexes

  • Aucun problème connexe^_^