Not see sql transactions

sergo · December 2, 2019, 2:42pm

If you are asking about a problem you are experiencing, please use the following template, as it will help us help you. If you have a different problem, please delete all of this text

**Kibana version **: 7.4.2

Elasticsearch version:7.4.2

APM Server version: 7.4.2

APM Agent language and version:.1.2 (net.core)
Dear guys when i use elastic apm for our project i dont see any sql requests in apm dashboards
i use
in code
app.UseAllElasticApm(Configuration);

example how to we go to database

services.AddEntityFrameworkSqlServer()
.AddDbContextPool(GrabItContextFactory.BuildOptions, poolSize: 512);”

GregKalapos · December 2, 2019, 2:58pm

Hi @sergo,

the config looks ok to me.

Could you maybe turn on trace logs and generate 1 request that talks to the database? Here is an example how you can change the loglevel - this one is Error, please change "Elastic.Apm to Trace.

sergo · December 2, 2019, 3:48pm

Thanks for your reply
below is an example request to application and log

Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://localhost:5000/api/search/saveusersearch application/json 1470
dbug: Elastic.Apm[0]
{ApmMiddleware} Incoming request. Starting Trace.
dbug: Elastic.Apm[0]
{AbstractConfigurationReader (MicrosoftExtensionsConfig)} Using provided transaction sample rate `1' parsed as 1
dbug: Elastic.Apm[0]
{Tracer} Starting Transaction{Id: 3fa4f442dfc4b7c7, TraceId: 078b31bc6a4ae19bb4474a7a2ef230ba, ParentId: null, Name: POST /api/search/saveusersearch, Type: request, IsSampled: True}
dbug: Elastic.Apm[0]

sergo · December 3, 2019, 9:25am

Hi @GregKalapos.

info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
      Request starting HTTP/1.1 POST http://localhost:5000/api/search/saveusersearch application/json 410
dbug: Elastic.Apm[0]
      {ApmMiddleware} Incoming request. Starting Trace.
dbug: Elastic.Apm[0]
      {AbstractConfigurationReader (MicrosoftExtensionsConfig)} Using provided transaction sample rate `1' parsed as 1
trce: Elastic.Apm[0]
      {CurrentExecutionSegmentsContainer.transaction} Setting value... Current thread: managed ID: 6. Current value: (null). New value: Transaction{Id: 381f33790ffca528, TraceId: 563dd84c7f5db70144273199bbd3eb5e, ParentId: null, Name: POST /api/search/saveusersearch, Type: request, IsSampled: True}.
trce: Elastic.Apm[0]
      {Transaction.381f33790ffca528} New Transaction instance created: Transaction{Id: 381f33790ffca528, TraceId: 563dd84c7f5db70144273199bbd3eb5e, ParentId: null, Name: POST /api/search/saveusersearch, Type: request, IsSampled: True}. IsSampled (True) is based on the given sampler (Sampler{ constant: True }). Start time: 2019-12-03 08:47:50.9556660 UTC (as timestamp: 1575362870955666)
dbug: Elastic.Apm[0]
      {Tracer} Starting Transaction{Id: 381f33790ffca528, TraceId: 563dd84c7f5db70144273199bbd3eb5e, ParentId: null, Name: POST /api/search/saveusersearch, Type: request, IsSampled: True}
info: Microsoft.AspNetCore.Cors.Infrastructure.CorsService[4]
      CORS policy execution successful.
info: Microsoft.AspNetCore.Authentication.Cookies.CookieAuthenticationHandler[7]
      Cookies was not authenticated. Failure message: Unprotect ticket failed
warn: Microsoft.AspNetCore.Session.SessionMiddleware[7]
      Error unprotecting the session cookie.
System.Security.Cryptography.CryptographicException: The key {07f2b3e2-5ee8-4908-b4fe-61d1bfac77da} was not found in the key ring.
   at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyRingBasedDataProtector.UnprotectCore(Byte[] protectedData, Boolean allowOperationsOnRevokedKeys, UnprotectStatus& status)
   at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyRingBasedDataProtector.DangerousUnprotect(Byte[] protectedData, Boolean ignoreRevocationErrors, Boolean& requiresMigration, Boolean& wasRevoked)
   at Microsoft.AspNetCore.DataProtection.KeyManagement.KeyRingBasedDataProtector.Unprotect(Byte[] protectedData)
   at Microsoft.AspNetCore.Session.CookieProtection.Unprotect(IDataProtector protector, String protectedText, ILogger logger)
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Route matched with {action = "SaveUserSearch", controller = "SearchApi", page = "", area = ""}. Executing action Homsters.Web.Controllers.API.SearchApiController.SaveUserSearch (Homsters.Web.Core)
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
      Executing action method Homsters.Web.Controllers.API.SearchApiController.SaveUserSearch (Homsters.Web.Core) with arguments (Homsters.Models.UserSearchModel) - Validation state: Valid
info: Microsoft.EntityFrameworkCore.Database.Command[20101]
      Executed DbCommand (0ms) [Parameters=[@__id_0='?' (DbType = Int64)], CommandType='Text', CommandTimeout='3600']
      SELECT TOP(1) [search].[Id], [search].[AdminUnitIds], [search].[AdministrativeUnitType_Id], [search].[BathRoomsCount], [search].[CommissioningMonth], [search].[CommissioningQuarter], [search].[CommissioningYear], [search].[ComplexTagIds], [search].[ConstructionStatus], [search].[Device], [search].[HasLift], [search].[Heating], [search].[HeatingMeter], [search].[HomstersUserId], [search].[HumanFriendlySearchFor], [search].[IndoorFinish], [search].[InstallmentPlan], [search].[IsItLegalized], [search].[Level], [search].[MilitaryMortgage], [search].[Mortgage], [search].[NeLat], [search].[NeLng], [search].[OptionToBuyGarage], [search].[OptionToBuyParkingSpace], [search].[Page], [search].[Parking], [search].[PriceFrom], [search].[PricePerSquareMeterFrom], [search].[PricePerSquareMeterTo], [search].[PriceTo], [search].[ProjectsCount], [search].[Promotion], [search].[ResidentialClass], [search].[RoomsCount], [search].[RoomsWithLivingRoomsCount], [search].[SearchFor], [search].[SearchId], [search].[SearchRequest], [search].[SearchTime], [search].[SizeFrom], [search].[SizeTo], [search].[Sort], [search].[SortDirection], [search].[SortingName], [search].[SortingResults], [search].[SortingVersion], [search].[SuggestSearchFor], [search].[SwLat], [search].[SwLng], [search].[Tags], [search].[Type], [search].[TypeOfHouse], [search].[ViewFromTheWindow], [search].[WithPhoto]
      FROM [dat].[UserSearches] AS [search]
      WHERE [search].[Id] = @__id_0

GregKalapos · December 3, 2019, 9:50am

Thanks @sergo for the logs.

This is tricky - so as it seems no span is created for the transaction. I just looked at the code that captures the DB statements, unfortunately we don’t have much logging there, I’ll open a PR and add more logs, but that won’t help us right now, since it’ll take some time to release the agent with the added logging.

Another idea I have would be to see if the currently active transaction is available at the point where you make the database call.

So, could you place this right before and also right after the database call:

Console.WriteLine(Agent.Tracer.CurrentTransaction.ToString());

If you don’t use console logging, just replace Console.WriteLine accordingly.

Agent.Tracer.CurrentTransaction.ToString() will print the current transaction and format it with all the info I need.

I think there could be 2 problems: either from some reason the transaction is not active when the agent tries to capture the db call - or the capturing itself is not working.

If we have the 1. problem we can verify it with the additional log, if it’s the second it’ll be harder.

sergo · December 3, 2019, 11:03am

thank @GregKalapos for your help
i added this

Transaction{Id: a4052e86a8a6b0a9, TraceId: 9067995a65ce838ba3fb79b350659937, ParentId: null, Name: POST /api/search/saveusersearch, Type: request, IsSampled: True}
trce: Elastic.Apm[0]
{CurrentExecutionSegmentsContainer.transaction} Getting value... Current thread: managed ID: 44. Current value: Transaction{Id: a4052e86a8a6b0a9, TraceId: 9067995a65ce838ba3fb79b350659937, ParentId: null, Name: POST /api/search/saveusersearch, Type: request, IsSampled: True}.
trce: Elastic.Apm[0]
{MetricsCollector} CollectAllMetrics started
trce: Elastic.Apm[0]
{MetricsCollector} Start collecting total and free memory
trce: Elastic.Apm[0]
{MetricsCollector} Collected total and free memory - adding it to MetricSet
trce: Elastic.Apm[0]
{MetricsCollector} Start collecting process's working set and virtual memory size
trce: Elastic.Apm[0]
{MetricsCollector} Collected process's working set and virtual memory size - adding it to MetricSet
trce: Elastic.Apm[0]
{MetricsCollector} Start collecting total system CPU time
trce: Elastic.Apm[0]
{MetricsCollector} Collected total system CPU time - adding it to MetricSet
trce: Elastic.Apm[0]
{MetricsCollector} Start collecting process total CPU time
trce: Elastic.Apm[0]
{MetricsCollector} Collected process total CPU time - adding it to MetricSet
dbug: Elastic.Apm[0]
{PayloadSenderV2} Enqueued MetricSet. newEventQueueCount: 10. MaxQueueEventCount: 1000. MetricSet: Elastic.Apm.Metrics.MetricSet.
dbug: Elastic.Apm[0]
{MetricsCollector} Metrics collected: MetricSample{system.memory.actual.free: 2231402496}, MetricSample{system.memory.total: 16568758272}, MetricSample{system.process.memory.size: 2222247055360}, MetricSample{system.process.memory.rss.bytes: 869830656}, MetricSample{system.cpu.total.norm.pct: 0.827885284423828}, MetricSample{system.process.cpu.total.norm.pct: 0.127065082043789}
trce: Elastic.Apm[0]
{SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Trying to execute task inline... Task: ID: 98, Status: WaitingToRun, AsyncState: System.Action}, taskWasPreviouslyQueued: False
trce: Elastic.Apm[0]
{SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Adding task... Task: ID: 98, Status: WaitingToRun, AsyncState: System.Action}
trce: Elastic.Apm[0]
{SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Added task. Task: ID: 98, Status: WaitingToRun, AsyncState: System.Action}
trce: Elastic.Apm[0]
{SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Starting to execute task... Task: ID: 98, Status: WaitingToRun, AsyncState: System.Action}
trce: Elastic.Apm[0]
{SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Trying to execute task inline... Task: ID: 99, Status: WaitingToRun, AsyncState: System.Action}, taskWasPreviouslyQueued: False
trce: Elastic.Apm[0]
{PayloadSenderV2} There's data to be sent. Batch size: 10. newEventQueueCount: 0. First event: Transaction{Id: 784bf67517a0b675, TraceId: 44cca718816d01977bdb74dc29f80b26, ParentId: null, Name: GET /Static/build/desktop/index20191203103148.js, Type: request, IsSampled: True}.
trce: Elastic.Apm[0]
{SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Trying to execute task inline... Task: ID: 100, Status: WaitingToRun, AsyncState: System.Action}, taskWasPreviouslyQueued: False
trce: Elastic.Apm[0]
{PayloadSenderV2} Serialized item to send: Transaction{Id: 784bf67517a0b675, TraceId: 44cca718816d01977bdb74dc29f80b26, ParentId: null, Name: GET /Static/build/desktop/index20191203103148.js, Type: request, IsSampled: True} as {"context":{"request":{"body":"","headers":{"Connection":"keep-alive","Accept":"/","Accept-Encoding":"gzip, deflate, br","Accept-Language":"en-US,en;q=0.9,ru;q=0.8,uk;q=0.7","Cookie":"Currency=TRY; hrs_tracked=1; hrs_main_page_city_photo=2; hrs_flat_plans_page=1; hrs_snippets_link_target=0; hrs_dubizzle_listing_page=1; hrs_dubizzle_search_page=1; _gcl_au=1.1.609283249.1570801234; _ym_d=1570801234; _ym_uid=1570801234628137431; hhm-ruid=f3006bb8-dfd2-e3fd-47e8-0dff4103fd42; _hjid=f4ab8559-f90f-41d9-a74d-fde29eb1075c; _hjIncludedInSample=1; User_ID_Projeland=e5d6f87b-7465-4010-a6fe-8959b5d76f93; language=ru; hrs_homsters_guarantee=0; hrs_search_demo_tour=0; viewedComplexes=%5B%7B%22id%22%3A7%7D%5D; cookiesNotificationHidden=1; unifises=PqaoV0xEH3kdWWKzqinredvl3byu1l14; csrf_token=7fw5sytxSQ1XwnirxRRNiiF3aZ0bVWzx; User_ID_Homsters=6e17837d-8e06-4f2a-aa59-7931fe2978da; hrs_user_visibility=0; _ga=GA1.1.1233964383.1575031151; CurrentUserSearch=424d1868-8ed8-4ecb-a5df-27f4e240768b; PrevUserSearch=424d1868-8ed8-4ecb-a5df-27f4e240768b; _gu=3d2e66b5-824c-4328-92e8-c0d8efeed553; _gs=2.s(src%3Dhttp%3A%2F%2Flocalhost%3A5000%2Fpersonal)c%5BDesktop%2CChrome%2C41%3A337%3A6788%3A%2CWindows%2C77.222.140.50%5D; _gid=GA1.1.84155127.1575291011; .AspNetCore.Session=CfDJ8OKz8gfoXghJtP5h0b%2Bsd9qSxBuAYX8o7tnSgVz%2FFz40GNDE0NXG3%2FH7%2BjhoWwvcCXHM59O6RiQdkp1%2BScUKcTB7E55zg8Ss0XUO9vDHdBJg%2Bqzkzu8LCp00pe2Ujn4jjD5h1ZdJKJ5h6UYawVfzdNz4wJ3Ud2wrDKAOn7QyN6bs; .AspNetCore.Antiforgery.0ra45_XpmrU=CfDJ8OKz8gfoXghJtP5h0b-sd9qAyZKoZuN9QeY3jPuD00-L9hryxShlHXe_C9OkudKeMfGTVn9I4w6NnQGHr6GoiBEzJuiLbxVu9ChJteX9G5KZxeX-2xXIVBRv-l1rhCMxrZDPKg24ePETjYL-nr3dssg; .AspNetCore.Cookies=CfDJ8OKz8gfoXghJtP5h0b-sd9peYe-ylOlB-28FgsutGNJ8iccn8sleAC2yCpyJKi89YuVNn6LXbvQUqdpRNQJsU5FAfHuOm0NL4aav9FRorcQqhP7vwu0KYCw9sBsDLv-jIVGSM0fhBRNd8qhJ-BD4s8pBp-tvh5yZMfERM3xg3Fjp2uBf447GP2cSK4LmhgfBPTo4OlwrumMjBMhOBbx5wANsvHqMQ36zX7OHVUsfmQcJubawAlU9CNNv7YKTN1IRws7McNSSpFT8RWqOekvzSneiVAY_700XP-PGppil72270WmRsELgnP72S_EBGU4nSHiPvV84YiGPNYZBID_iZjTlQ7-LJBT3ebzwXxMDcUU9qKAvPJhc5grILIq25nN8WhmMgiSPXwwn-JBxBrTI55Plskx7KyhuaArLBRi3OvC5s_EwJsBtA42DOFTpYTPrLLwBx4bpZsX2MxGUetthIqE2M0cHsrK3KCXWJ5fZC_9b8KwJ-ivjTloP1k_MnA0-Qtk7SZBxTym-lGqwyagFum3qCF7_5cI4o7TbxMJAtuO-3JLn75cxhZkxX144JfuavboPTtidCrEZpmtTtG-AS9FTyr1Ruj0IRCfTaJ8rksHOOmh2OdJfLVgLfXse1yISaF8UNaKCCqcOZcccrqPulBN_UX6kYXXS8elvr28PIreWbsjyT9OD751nkwD8OiCvcVwq1fjsFIm6d9NIYEQNp4pkIRZYP5dhZ-VQhJ27fKSqkvUjCcZc0GVHBehzj29nQQwZN0H7CoFv0O7oZZVvRJ64b1s0CWumUk8yuCokmNeKhG6h5cOv0MOPvozBpw45L-wPsAN85bfF-dLL7ih_0bm0OJr-H-EhE19KqWlpzfJ17pltZU6GU5YgjPLfcUBDm2SoZtLimUys7LhR8bOUXqwbkXerGmhVlKge5eGajxnDR9ArRasIu3qEFAIgIRRvTVqpEF6Tv_1bUi-cS3M-SIsWc1Q2Uj5OWV4yjmJv8GTqFolqFCeMTaRNjAmzPIE8yUPJrTHVHiBPCdyi7L4LE-AbzQHMf_JVO_vJQZaCk4-EbfDFJUCHFFdfLprDYG-vsVwCNIdL8CO_1Ul2tihGLuZh19_3sWZLG3Uev_VWo0oKynN0bDBXUEUgW12te9fKFIg4R6TJJ-5M_oDPsatjEea1GhS0_QyLG2rkC-7fuJzdfEVvLMUdFAmRikA3iX3Fdxmk_zQ33sfWu5w_05mxG-E_YvBAZr9N9Lnh9jcjXwcERLuuYCV6i6jmxd1mXD6MS_FWJIdhL4jMsrN_jtecbwZmOe95oJvPNG0RK9-CP1A4VzUDraokDfHZQHaVVAGmm4WJYXY4xWtZ34MUo3AlGDqiiBMffqgM7m1I35AyZHbWSlS7qwieFhHKtN7snpQW_pCFd9UpPVrwminpHsUgpWHqBHyo1zaiEhPjwNivAQ1ArobhWalGuClD8tqx2RKFktjfB7PAFqB-pGwOnViP_fcbC4oW95EQn_X70sDx-GupCw4fNYxEon3uI49iD8hHFTsoEoEC7tq39QltVaW2nDy1JKTvaX9toje7ZVy9_OojpAHjD9KVTuHKfDa3feukq0RNJVT7hYoDCwtTXKXih--adKtretNJUeU0XJ7NLLhj7I5tAa-UyiZk3DUQY2gHkkjnY03DPApZgCHt2qWs3hQYE7kSLpKdomdVRPzrxCv6VQk-WKtUz5a_e2OFrgs-adb_VY8hi0HaZcPExH34tYDfXzepxTZkHRGrcF8Zkkj-lWuHZTpBIaA7T6XAJL4bgJjEejwt7-oQ8Iu0PyV11FoZFsSvuKM-CXaVkC9dY77LTf5_jskDQL2iQ6FWYou5v4JjAvDn7e8tE1txdVi77_noEMGIKKpRQkUTA2rPp8wzqpfturtz2NHC0U8FTn0nZO6mXswGnkowW62F_FqxJ_CF89wiZFPv_Fbmjxg0V9soqmHI0T34zjAsVUQsFUmCdQ; LastSearchDate=%7B%22date%22%3A%2203.12.2019%22%7D; AMP_TOKEN=%24NOT_FOUND; LastSearchInfo=%7B%22RoomsCount%22%3A447%2C%22Type%22%3A127%2C%22TypeOfSearchComplexOrEstate%22%3A1%2C%22priceFrom%22%3Anull%2C%22priceTo%22%3Anull%2C%22cityName%22%3A%22%D0%92%D1%81%D0%B5%20%D0%B3%D0%BE%D1%80%D0%BE%D0%B4%D0%B0%22%2C%22AdminUnitsId%22%3A%5B1%5D%2C%22Sort%22%3A1%2C%22SortDirection%22%3A1%2C%22PricePerSquareMeterFrom%22%3Anull%2C%22PricePerSquareMeterTo%22%3Anull%2C%22TagIds%22%3Anull%2C%22sizeFrom%22%3Anull%2C%22sizeTo%22%3Anull%2C%22InstallmentPlan%22%3Afalse%2C%22Promotion%22%3Anull%2C%22AdministrativeUnitType%22%3A1%2C%22ApartmentType%22%3A15%2C%22RoomsAndHalfRoomsCount%22%3A0%2C%22FloorsString%22%3Anull%2C%22ConstructionStatus%22%3A0%2C%22Parking%22%3A31%2C%22BathRoomsCount%22%3A127%2C%22HasLift%22%3Afalse%7D; LinkToLastSearch=https%3A%2F%2Flocalhost%3A5001%2Fprojects%3FSort%3DFeatured%26SortDirection%3DDescending%26TypeOfSearchComplexOrEstate%3D1%26currency%3DTRY%26page%3D1%26AdminUnitsId%3D1%26AdministrativeUnitType%3D1%26Type%3D127%26RoomsCount%3D447%26BathRoomsCount%3D127%26Parking%3D31%26ApartmentType%3D15%26ConstructionStatus%3D0%26HasLift%3DFalse%26InstallmentPlan%3DFalse; UserSearchId=592347; _gw=2.u%5B%2C%2C%2C%2C%5Dv%5B~fmrde%2C~0%2C~1%5Da(18255-140076161~93yj)","Host":"localhost:5001","Referer":"https://localhost:5001/projects","User-Agent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.108 Safari/537.36","Sec-Fetch-Site":"same-origin","Sec-Fetch-Mode":"no-cors"},"http_version":"1.1","method":"GET","socket":{"encrypted":true,"remote_address":"::1"},"url":{"full":"https://localhost:5001/Static/build/desktop/index20191203103148.js","hostname":"localhost","pathname":"/Static/build/desktop/index20191203103148.js","protocol":"HTTP","raw":"https://localhost:5001/Static/build/desktop/index20191203103148.js","search":""}},"response":{"finished":true,"headers":{"cache-Control":"public,max-age=172800","date":"Tue, 03 Dec 2019 10:31:48 GMT","transfer-Encoding":"chunked","content-Type":"application/javascript","content-Encoding":"gzip","last-Modified":"Fri, 29 Nov 2019 10:23:38 GMT","accept-Ranges":"bytes","eTag":""1d5a69f1042237c"","server":"Kestrel","vary":"Accept-Encoding","x-Frame-Options":"ALLOW-FROM "},"status_code":200}},"duration":21.821,"id":"784bf67517a0b675","sampled":true,"name":"GET /Static/build/desktop/index20191203103148.js","result":"HTTP 2xx","span_count":{"dropped":0,"started":0},"timestamp":1575369108761780,"trace_id":"44cca718816d01977bdb74dc29f80b26","type":"request"}
trce: Elastic.Apm[0]

sergo · December 3, 2019, 11:10am

trce: Elastic.Apm[0]
      {PayloadSenderV2} Serialized item to send: Transaction{Id: 99d1fa005da5323f, TraceId: 8d1d4e3ba86ad39597f9083df7537514, ParentId: null, Name: GET /Static/build/desktop/index20191203103148.css, Type: request, IsSampled: True} as {"context":{"request":{"body":"","headers":{"Connection":"keep-alive","Accept":"text/css,*/*;q=0.1","Accept-Encoding":"gzip, deflate, br","Accept-Language":"en-US,en;q=0.9,ru;q=0.8,uk;q=0.7","Cookie":"Currency=TRY; hrs_tracked=1; hrs_main_page_city_photo=2; hrs_flat_plans_page=1; hrs_snippets_link_target=0; hrs_dubizzle_listing_page=1; hrs_dubizzle_search_page=1; _gcl_au=1.1.609283249.1570801234; _ym_d=1570801234; _ym_uid=1570801234628137431; hhm-ruid=f3006bb8-dfd2-e3fd-47e8-0dff4103fd42; _hjid=f4ab8559-f90f-41d9-a74d-fde29eb1075c; _hjIncludedInSample=1; User_ID_Projeland=e5d6f87b-7465-4010-a6fe-8959b5d76f93; language=ru; hrs_homsters_guarantee=0; hrs_search_demo_tour=0; viewedComplexes=%5B%7B%22id%22%3A7%7D%5D; cookiesNotificationHidden=1; unifises=PqaoV0xEH3kdWWKzqinredvl3byu1l14; csrf_token=7fw5sytxSQ1XwnirxRRNiiF3aZ0bVWzx; User_ID_Homsters=6e17837d-8e06-4f2a-aa59-7931fe2978da; hrs_user_visibility=0; _ga=GA1.1.1233964383.1575031151; CurrentUserSearch=424d1868-8ed8-4ecb-a5df-27f4e240768b; PrevUserSearch=424d1868-8ed8-4ecb-a5df-27f4e240768b; _gu=3d2e66b5-824c-4328-92e8-c0d8efeed553; _gs=2.s(src%3Dhttp%3A%2F%2Flocalhost%3A5000%2Fpersonal)c%5BDesktop%2CChrome%2C41%3A337%3A6788%3A%2CWindows%2C77.222.140.50%5D; _gid=GA1.1.84155127.1575291011; .AspNetCore.Session=CfDJ8OKz8gfoXghJtP5h0b%2Bsd9qSxBuAYX8o7tnSgVz%2FFz40GNDE0NXG3%2FH7%2BjhoWwvcCXHM59O6RiQdkp1%2BScUKcTB7E55zg8Ss0XUO9vDHdBJg%2Bqzkzu8LCp00pe2Ujn4jjD5h1ZdJKJ5h6UYawVfzdNz4wJ3Ud2wrDKAOn7QyN6bs; .AspNetCore.Antiforgery.0ra45_XpmrU=CfDJ8OKz8gfoXghJtP5h0b-sd9qAyZKoZuN9QeY3jPuD00-L9hryxShlHXe_C9OkudKeMfGTVn9I4w6NnQGHr6GoiBEzJuiLbxVu9ChJteX9G5KZxeX-2xXIVBRv-l1rhCMxrZDPKg24ePETjYL-nr3dssg; .AspNetCore.Cookies=CfDJ8OKz8gfoXghJtP5h0b-sd9peYe-ylOlB-28FgsutGNJ8iccn8sleAC2yCpyJKi89YuVNn6LXbvQUqdpRNQJsU5FAfHuOm0NL4aav9FRorcQqhP7vwu0KYCw9sBsDLv-jIVGSM0fhBRNd8qhJ-BD4s8pBp-tvh5yZMfERM3xg3Fjp2uBf447GP2cSK4LmhgfBPTo4OlwrumMjBMhOBbx5wANsvHqMQ36zX7OHVUsfmQcJubawAlU9CNNv7YKTN1IRws7McNSSpFT8RWqOekvzSneiVAY_700XP-PGppil72270WmRsELgnP72S_EBGU4nSHiPvV84YiGPNYZBID_iZjTlQ7-LJBT3ebzwXxMDcUU9qKAvPJhc5grILIq25nN8WhmMgiSPXwwn-JBxBrTI55Plskx7KyhuaArLBRi3OvC5s_EwJsBtA42DOFTpYTPrLLwBx4bpZsX2MxGUetthIqE2M0cHsrK3KCXWJ5fZC_9b8KwJ-ivjTloP1k_MnA0-Qtk7SZBxTym-lGqwyagFum3qCF7_5cI4o7TbxMJAtuO-3JLn75cxhZkxX144JfuavboPTtidCrEZpmtTtG-AS9FTyr1Ruj0IRCfTaJ8rksHOOmh2OdJfLVgLfXse1yISaF8UNaKCCqcOZcccrqPulBN_UX6kYXXS8elvr28PIreWbsjyT9OD751nkwD8OiCvcVwq1fjsFIm6d9NIYEQNp4pkIRZYP5dhZ-VQhJ27fKSqkvUjCcZc0GVHBehzj29nQQwZN0H7CoFv0O7oZZVvRJ64b1s0CWumUk8yuCokmNeKhG6h5cOv0MOPvozBpw45L-wPsAN85bfF-dLL7ih_0bm0OJr-H-EhE19KqWlpzfJ17pltZU6GU5YgjPLfcUBDm2SoZtLimUys7LhR8bOUXqwbkXerGmhVlKge5eGajxnDR9ArRasIu3qEFAIgIRRvTVqpEF6Tv_1bUi-cS3M-SIsWc1Q2Uj5OWV4yjmJv8GTqFolqFCeMTaRNjAmzPIE8yUPJrTHVHiBPCdyi7L4LE-AbzQHMf_JVO_vJQZaCk4-EbfDFJUCHFFdfLprDYG-vsVwCNIdL8CO_1Ul2tihGLuZh19_3sWZLG3Uev_VWo0oKynN0bDBXUEUgW12te9fKFIg4R6TJJ-5M_oDPsatjEea1GhS0_QyLG2rkC-7fuJzdfEVvLMUdFAmRikA3iX3Fdxmk_zQ33sfWu5w_05mxG-E_YvBAZr9N9Lnh9jcjXwcERLuuYCV6i6jmxd1mXD6MS_FWJIdhL4jMsrN_jtecbwZmOe95oJvPNG0RK9-CP1A4VzUDraokDfHZQHaVVAGmm4WJYXY4xWtZ34MUo3AlGDqiiBMffqgM7m1I35AyZHbWSlS7qwieFhHKtN7snpQW_pCFd9UpPVrwminpHsUgpWHqBHyo1zaiEhPjwNivAQ1ArobhWalGuClD8tqx2RKFktjfB7PAFqB-pGwOnViP_fcbC4oW95EQn_X70sDx-GupCw4fNYxEon3uI49iD8hHFTsoEoEC7tq39QltVaW2nDy1JKTvaX9toje7ZVy9_OojpAHjD9KVTuHKfDa3feukq0RNJVT7hYoDCwtTXKXih--adKtretNJUeU0XJ7NLLhj7I5tAa-UyiZk3DUQY2gHkkjnY03DPApZgCHt2qWs3hQYE7kSLpKdomdVRPzrxCv6VQk-WKtUz5a_e2OFrgs-adb_VY8hi0HaZcPExH34tYDfXzepxTZkHRGrcF8Zkkj-lWuHZTpBIaA7T6XAJL4bgJjEejwt7-oQ8Iu0PyV11FoZFsSvuKM-CXaVkC9dY77LTf5_jskDQL2iQ6FWYou5v4JjAvDn7e8tE1txdVi77_noEMGIKKpRQkUTA2rPp8wzqpfturtz2NHC0U8FTn0nZO6mXswGnkowW62F_FqxJ_CF89wiZFPv_Fbmjxg0V9soqmHI0T34zjAsVUQsFUmCdQ; LastSearchDate=%7B%22date%22%3A%2203.12.2019%22%7D; AMP_TOKEN=%24NOT_FOUND; LastSearchInfo=%7B%22RoomsCount%22%3A447%2C%22Type%22%3A127%2C%22TypeOfSearchComplexOrEstate%22%3A1%2C%22priceFrom%22%3Anull%2C%22priceTo%22%3Anull%2C%22cityName%22%3A%22%D0%92%D1%81%D0%B5%20%D0%B3%D0%BE%D1%80%D0%BE%D0%B4%D0%B0%22%2C%22AdminUnitsId%22%3A%5B1%5D%2C%22Sort%22%3A1%2C%22SortDirection%22%3A1%2C%22PricePerSquareMeterFrom%22%3Anull%2C%22PricePerSquareMeterTo%22%3Anull%2C%22TagIds%22%3Anull%2C%22sizeFrom%22%3Anull%2C%22sizeTo%22%3Anull%2C%22InstallmentPlan%22%3Afalse%2C%22Promotion%22%3Anull%2C%22AdministrativeUnitType%22%3A1%2C%22ApartmentType%22%3A15%2C%22RoomsAndHalfRoomsCount%22%3A0%2C%22FloorsString%22%3Anull%2C%22ConstructionStatus%22%3A0%2C%22Parking%22%3A31%2C%22BathRoomsCount%22%3A127%2C%22HasLift%22%3Afalse%7D; LinkToLastSearch=https%3A%2F%2Flocalhost%3A5001%2Fprojects%3FSort%3DFeatured%26SortDirection%3DDescending%26TypeOfSearchComplexOrEstate%3D1%26currency%3DTRY%26page%3D1%26AdminUnitsId%3D1%26AdministrativeUnitType%3D1%26Type%3D127%26RoomsCount%3D447%26BathRoomsCount%3D127%26Parking%3D31%26ApartmentType%3D15%26ConstructionStatus%3D0%26HasLift%3DFalse%26InstallmentPlan%3DFalse; UserSearchId=592347; _gw=2.u%5B%2C%2C%2C%2C%5Dv%5B~fmrde%2C~0%2C~1%5Da(18255-140076161~93yj)","Host":"localhost:5001","Referer":"https://localhost:5001/projects","User-Agent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.108 Safari/537.36","Sec-Fetch-Site":"same-origin","Sec-Fetch-Mode":"no-cors"},"http_version":"1.1","method":"GET","socket":{"encrypted":true,"remote_address":"::1"},"url":{"full":"https://localhost:5001/Static/build/desktop/index20191203103148.css","hostname":"localhost","pathname":"/Static/build/desktop/index20191203103148.css","protocol":"HTTP","raw":"https://localhost:5001/Static/build/desktop/index20191203103148.css","search":""}},"response":{"finished":true,"headers":{"cache-Control":"public,max-age=172800","date":"Tue, 03 Dec 2019 10:31:48 GMT","transfer-Encoding":"chunked","content-Type":"text/css","content-Encoding":"gzip","last-Modified":"Fri, 29 Nov 2019 10:23:38 GMT","accept-Ranges":"bytes","eTag":"\"1d5a69f1041e542\"","server":"Kestrel","vary":"Accept-Encoding","x-Frame-Options":"ALLOW-FROM "},"status_code":200}},"duration":4.373,"id":"99d1fa005da5323f","sampled":true,"name":"GET /Static/build/desktop/index20191203103148.css","result":"HTTP 2xx","span_count":{"dropped":0,"started":0},"timestamp":1575369108785457,"trace_id":"8d1d4e3ba86ad39597f9083df7537514","type":"request"}
trce: Elastic.Apm[0]

sergo · December 3, 2019, 11:10am

{PayloadSenderV2} Serialized item to send: Transaction{Id: 58ded59313fe40d3, TraceId: cc32a59a5cc2d17a9fadb970b665e551, ParentId: null, Name: GET /Static/build/desktop/LayoutBundle20191203103148.js, Type: request, IsSampled: True} as {"context":{"request":{"body":"","headers":{"Connection":"keep-alive","Accept":"/","Accept-Encoding":"gzip, deflate, br","Accept-Language":"en-US,en;q=0.9,ru;q=0.8,uk;q=0.7","Cookie":"Currency=TRY; hrs_tracked=1; hrs_main_page_city_photo=2; hrs_flat_plans_page=1; hrs_snippets_link_target=0; hrs_dubizzle_listing_page=1; hrs_dubizzle_search_page=1; _gcl_au=1.1.609283249.1570801234; _ym_d=1570801234; _ym_uid=1570801234628137431; hhm-ruid=f3006bb8-dfd2-e3fd-47e8-0dff4103fd42; _hjid=f4ab8559-f90f-41d9-a74d-fde29eb1075c; _hjIncludedInSample=1; User_ID_Projeland=e5d6f87b-7465-4010-a6fe-8959b5d76f93; language=ru; hrs_homsters_guarantee=0; hrs_search_demo_tour=0; viewedComplexes=%5B%7B%22id%22%3A7%7D%5D; cookiesNotificationHidden=1; unifises=PqaoV0xEH3kdWWKzqinredvl3byu1l14; csrf_token=7fw5sytxSQ1XwnirxRRNiiF3aZ0bVWzx; User_ID_Homsters=6e17837d-8e06-4f2a-aa59-7931fe2978da; hrs_user_visibility=0; _ga=GA1.1.1233964383.1575031151; CurrentUserSearch=424d1868-8ed8-4ecb-a5df-27f4e240768b; PrevUserSearch=424d1868-8ed8-4ecb-a5df-27f4e240768b; _gu=3d2e66b5-824c-4328-92e8-c0d8efeed553; _gs=2.s(src%3Dhttp%3A%2F%2Flocalhost%3A5000%2Fpersonal)c%5BDesktop%2CChrome%2C41%3A337%3A6788%3A%2CWindows%2C77.222.140.50%5D; _gid=GA1.1.84155127.1575291011; .AspNetCore.Session=CfDJ8OKz8gfoXghJtP5h0b%2Bsd9qSxBuAYX8o7tnSgVz%2FFz40GNDE0NXG3%2FH7%2BjhoWwvcCXHM59O6RiQdkp1%2BScUKcTB7E55zg8Ss0XUO9vDHdBJg%2Bqzkzu8LCp00pe2Ujn4jjD5h1ZdJKJ5h6UYawVfzdNz4wJ3Ud2wrDKAOn7QyN6bs; .AspNetCore.Antiforgery.0ra45_XpmrU=CfDJ8OKz8gfoXghJtP5h0b-sd9qAyZKoZuN9QeY3jPuD00-L9hryxShlHXe_C9OkudKeMfGTVn9I4w6NnQGHr6GoiBEzJuiLbxVu9ChJteX9G5KZxeX-2xXIVBRv-l1rhCMxrZDPKg24ePETjYL-nr3dssg; .AspNetCore.Cookies=CfDJ8OKz8gfoXghJtP5h0b-sd9peYe-ylOlB-28FgsutGNJ8iccn8sleAC2yCpyJKi89YuVNn6LXbvQUqdpRNQJsU5FAfHuOm0NL4aav9FRorcQqhP7vwu0KYCw9sBsDLv-jIVGSM0fhBRNd8qhJ-BD4s8pBp-tvh5yZMfERM3xg3Fjp2uBf447GP2cSK4LmhgfBPTo4OlwrumMjBMhOBbx5wANsvHqMQ36zX7OHVUsfmQcJubawAlU9CNNv7YKTN1IRws7McNSSpFT8RWqOekvzSneiVAY_700XP-PGppil72270WmRsELgnP72S_EBGU4nSHiPvV84YiGPNYZBID_iZjTlQ7-LJBT3ebzwXxMDcUU9qKAvPJhc5grILIq25nN8WhmMgiSPXwwn-JBxBrTI55Plskx7KyhuaArLBRi3OvC5s_EwJsBtA42DOFTpYTPrLLwBx4bpZsX2MxGUetthIqE2M0cHsrK3KCXWJ5fZC_9b8KwJ-ivjTloP1k_MnA0-Qtk7SZBxTym-lGqwyagFum3qCF7_5cI4o7TbxMJAtuO-3JLn75cxhZkxX144JfuavboPTtidCrEZpmtTtG-AS9FTyr1Ruj0IRCfTaJ8rksHOOmh2OdJfLVgLfXse1yISaF8UNaKCCqcOZcccrqPulBN_UX6kYXXS8elvr28PIreWbsjyT9OD751nkwD8OiCvcVwq1fjsFIm6d9NIYEQNp4pkIRZYP5dhZ-VQhJ27fKSqkvUjCcZc0GVHBehzj29nQQwZN0H7CoFv0O7oZZVvRJ64b1s0CWumUk8yuCokmNeKhG6h5cOv0MOPvozBpw45L-wPsAN85bfF-dLL7ih_0bm0OJr-H-EhE19KqWlpzfJ17pltZU6GU5YgjPLfcUBDm2SoZtLimUys7LhR8bOUXqwbkXerGmhVlKge5eGajxnDR9ArRasIu3qEFAIgIRRvTVqpEF6Tv_1bUi-cS3M-SIsWc1Q2Uj5OWV4yjmJv8GTqFolqFCeMTaRNjAmzPIE8yUPJrTHVHiBPCdyi7L4LE-AbzQHMf_JVO_vJQZaCk4-EbfDFJUCHFFdfLprDYG-vsVwCNIdL8CO_1Ul2tihGLuZh19_3sWZLG3Uev_VWo0oKynN0bDBXUEUgW12te9fKFIg4R6TJJ-5M_oDPsatjEea1GhS0_QyLG2rkC-7fuJzdfEVvLMUdFAmRikA3iX3Fdxmk_zQ33sfWu5w_05mxG-E_YvBAZr9N9Lnh9jcjXwcERLuuYCV6i6jmxd1mXD6MS_FWJIdhL4jMsrN_jtecbwZmOe95oJvPNG0RK9-CP1A4VzUDraokDfHZQHaVVAGmm4WJYXY4xWtZ34MUo3AlGDqiiBMffqgM7m1I35AyZHbWSlS7qwieFhHKtN7snpQW_pCFd9UpPVrwminpHsUgpWHqBHyo1zaiEhPjwNivAQ1ArobhWalGuClD8tqx2RKFktjfB7PAFqB-pGwOnViP_fcbC4oW95EQn_X70sDx-GupCw4fNYxEon3uI49iD8hHFTsoEoEC7tq39QltVaW2nDy1JKTvaX9toje7ZVy9_OojpAHjD9KVTuHKfDa3feukq0RNJVT7hYoDCwtTXKXih--adKtretNJUeU0XJ7NLLhj7I5tAa-UyiZk3DUQY2gHkkjnY03DPApZgCHt2qWs3hQYE7kSLpKdomdVRPzrxCv6VQk-WKtUz5a_e2OFrgs-adb_VY8hi0HaZcPExH34tYDfXzepxTZkHRGrcF8Zkkj-lWuHZTpBIaA7T6XAJL4bgJjEejwt7-oQ8Iu0PyV11FoZFsSvuKM-CXaVkC9dY77LTf5_jskDQL2iQ6FWYou5v4JjAvDn7e8tE1txdVi77_noEMGIKKpRQkUTA2rPp8wzqpfturtz2NHC0U8FTn0nZO6mXswGnkowW62F_FqxJ_CF89wiZFPv_Fbmjxg0V9soqmHI0T34zjAsVUQsFUmCdQ; LastSearchDate=%7B%22date%22%3A%2203.12.2019%22%7D; AMP_TOKEN=%24NOT_FOUND; LastSearchInfo=%7B%22RoomsCount%22%3A447%2C%22Type%22%3A127%2C%22TypeOfSearchComplexOrEstate%22%3A1%2C%22priceFrom%22%3Anull%2C%22priceTo%22%3Anull%2C%22cityName%22%3A%22%D0%92%D1%81%D0%B5%20%D0%B3%D0%BE%D1%80%D0%BE%D0%B4%D0%B0%22%2C%22AdminUnitsId%22%3A%5B1%5D%2C%22Sort%22%3A1%2C%22SortDirection%22%3A1%2C%22PricePerSquareMeterFrom%22%3Anull%2C%22PricePerSquareMeterTo%22%3Anull%2C%22TagIds%22%3Anull%2C%22sizeFrom%22%3Anull%2C%22sizeTo%22%3Anull%2C%22InstallmentPlan%22%3Afalse%2C%22Promotion%22%3Anull%2C%22AdministrativeUnitType%22%3A1%2C%22ApartmentType%22%3A15%2C%22RoomsAndHalfRoomsCount%22%3A0%2C%22FloorsString%22%3Anull%2C%22ConstructionStatus%22%3A0%2C%22Parking%22%3A31%2C%22BathRoomsCount%22%3A127%2C%22HasLift%22%3Afalse%7D; LinkToLastSearch=https%3A%2F%2Flocalhost%3A5001%2Fprojects%3FSort%3DFeatured%26SortDirection%3DDescending%26TypeOfSearchComplexOrEstate%3D1%26currency%3DTRY%26page%3D1%26AdminUnitsId%3D1%26AdministrativeUnitType%3D1%26Type%3D127%26RoomsCount%3D447%26BathRoomsCount%3D127%26Parking%3D31%26ApartmentType%3D15%26ConstructionStatus%3D0%26HasLift%3DFalse%26InstallmentPlan%3DFalse; UserSearchId=592347; _gw=2.u%5B%2C%2C%2C%2C%5Dv%5B~fmrde%2C~0%2C~1%5Da(18255-140076161~93yj)","Host":"localhost:5001","Referer":"https://localhost:5001/projects","User-Agent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.108 Safari/537.36","Sec-Fetch-Site":"same-origin","Sec-Fetch-Mode":"no-cors"},"http_version":"1.1","method":"GET","socket":{"encrypted":true,"remote_address":"::1"},"url":{"full":"https://localhost:5001/Static/build/desktop/LayoutBundle20191203103148.js","hostname":"localhost","pathname":"/Static/build/desktop/LayoutBundle20191203103148.js","protocol":"HTTP","raw":"https://localhost:5001/Static/build/desktop/LayoutBundle20191203103148.js","search":""}},"response":{"finished":true,"headers":{"cache-Control":"public,max-age=172800","date":"Tue, 03 Dec 2019 10:31:48 GMT","transfer-Encoding":"chunked","content-Type":"application/javascript","content-Encoding":"gzip","last-Modified":"Fri, 29 Nov 2019 10:23:38 GMT","accept-Ranges":"bytes","eTag":""1d5a69f1042caa4"","server":"Kestrel","vary":"Accept-Encoding","x-Frame-Options":"ALLOW-FROM "},"status_code":200}},"duration":7.677,"id":"58ded59313fe40d3","sampled":true,"name":"GET /Static/build/desktop/LayoutBundle20191203103148.js","result":"HTTP 2xx","span_count":{"dropped":0,"started":0},"timestamp":1575369108849001,"trace_id":"cc32a59a5cc2d17a9fadb970b665e551","type":"request"}
trce: Elastic.Apm[0]

sergo · December 3, 2019, 11:12am

trce: Elastic.Apm[0]
{PayloadSenderV2} Serialized item to send: Elastic.Apm.Metrics.MetricSet as {"samples":{"system.memory.actual.free":{"value":2272096256.0},"system.memory.total":{"value":16568758272.0},"system.process.memory.size":{"value":2222246662144.0},"system.process.memory.rss.bytes":{"value":869203968.0},"system.cpu.total.norm.pct":{"value":0.80117996215820309},"system.process.cpu.total.norm.pct":{"value":0.070163542798638484}},"timestamp":1575369109129833}
trce: Elastic.Apm[0]
{PayloadSenderV2} Serialized item to send: Transaction{Id: c21aff5e5aa7d545, TraceId: 5be66fef6ad7c928f071083029fefcd7, ParentId: null, Name: POST RecommendationApi/SaveUserNavigationAsync, Type: request, IsSampled: True} as {"context":{"request":{"body":"","headers":{"Connection":"keep-alive","Content-Type":"application/json","Accept":"/","Accept-Encoding":"gzip, deflate, br","Accept-Language":"en-US,en;q=0.9,ru;q=0.8,uk;q=0.7","Cookie":"Currency=TRY; hrs_tracked=1; hrs_main_page_city_photo=2; hrs_flat_plans_page=1; hrs_snippets_link_target=0; hrs_dubizzle_listing_page=1; hrs_dubizzle_search_page=1; _gcl_au=1.1.609283249.1570801234; _ym_d=1570801234; _ym_uid=1570801234628137431; hhm-ruid=f3006bb8-dfd2-e3fd-47e8-0dff4103fd42; _hjid=f4ab8559-f90f-41d9-a74d-fde29eb1075c; _hjIncludedInSample=1; User_ID_Projeland=e5d6f87b-7465-4010-a6fe-8959b5d76f93; language=ru; hrs_homsters_guarantee=0; hrs_search_demo_tour=0; viewedComplexes=%5B%7B%22id%22%3A7%7D%5D; cookiesNotificationHidden=1; unifises=PqaoV0xEH3kdWWKzqinredvl3byu1l14; csrf_token=7fw5sytxSQ1XwnirxRRNiiF3aZ0bVWzx; User_ID_Homsters=6e17837d-8e06-4f2a-aa59-7931fe2978da; hrs_user_visibility=0; _ga=GA1.1.1233964383.1575031151; CurrentUserSearch=424d1868-8ed8-4ecb-a5df-27f4e240768b; PrevUserSearch=424d1868-8ed8-4ecb-a5df-27f4e240768b; _gu=3d2e66b5-824c-4328-92e8-c0d8efeed553; _gs=2.s(src%3Dhttp%3A%2F%2Flocalhost%3A5000%2Fpersonal)c%5BDesktop%2CChrome%2C41%3A337%3A6788%3A%2CWindows%2C77.222.140.50%5D; _gid=GA1.1.84155127.1575291011; .AspNetCore.Session=CfDJ8OKz8gfoXghJtP5h0b%2Bsd9qSxBuAYX8o7tnSgVz%2FFz40GNDE0NXG3%2FH7%2BjhoWwvcCXHM59O6RiQdkp1%2BScUKcTB7E55zg8Ss0XUO9vDHdBJg%2Bqzkzu8LCp00pe2Ujn4jjD5h1ZdJKJ5h6UYawVfzdNz4wJ3Ud2wrDKAOn7QyN6bs; .AspNetCore.Antiforgery.0ra45_XpmrU=CfDJ8OKz8gfoXghJtP5h0b-sd9qAyZKoZuN9QeY3jPuD00-L9hryxShlHXe_C9OkudKeMfGTVn9I4w6NnQGHr6GoiBEzJuiLbxVu9ChJteX9G5KZxeX-2xXIVBRv-l1rhCMxrZDPKg24ePETjYL-nr3dssg; .AspNetCore.Cookies=CfDJ8OKz8gfoXghJtP5h0b-sd9peYe-ylOlB-28FgsutGNJ8iccn8sleAC2yCpyJKi89YuVNn6LXbvQUqdpRNQJsU5FAfHuOm0NL4aav9FRorcQqhP7vwu0KYCw9sBsDLv-jIVGSM0fhBRNd8qhJ-BD4s8pBp-tvh5yZMfERM3xg3Fjp2uBf447GP2cSK4LmhgfBPTo4OlwrumMjBMhOBbx5wANsvHqMQ36zX7OHVUsfmQcJubawAlU9CNNv7YKTN1IRws7McNSSpFT8RWqOekvzSneiVAY_700XP-PGppil72270WmRsELgnP72S_EBGU4nSHiPvV84YiGPNYZBID_iZjTlQ7-LJBT3ebzwXxMDcUU9qKAvPJhc5grILIq25nN8WhmMgiSPXwwn-JBxBrTI55Plskx7KyhuaArLBRi3OvC5s_EwJsBtA42DOFTpYTPrLLwBx4bpZsX2MxGUetthIqE2M0cHsrK3KCXWJ5fZC_9b8KwJ-ivjTloP1k_MnA0-Qtk7SZBxTym-lGqwyagFum3qCF7_5cI4o7TbxMJAtuO-3JLn75cxhZkxX144JfuavboPTtidCrEZpmtTtG-AS9FTyr1Ruj0IRCfTaJ8rksHOOmh2OdJfLVgLfXse1yISaF8UNaKCCqcOZcccrqPulBN_UX6kYXXS8elvr28PIreWbsjyT9OD751nkwD8OiCvcVwq1fjsFIm6d9NIYEQNp4pkIRZYP5dhZ-VQhJ27fKSqkvUjCcZc0GVHBehzj29nQQwZN0H7CoFv0O7oZZVvRJ64b1s0CWumUk8yuCokmNeKhG6h5cOv0MOPvozBpw45L-wPsAN85bfF-dLL7ih_0bm0OJr-H-EhE19KqWlpzfJ17pltZU6GU5YgjPLfcUBDm2SoZtLimUys7LhR8bOUXqwbkXerGmhVlKge5eGajxnDR9ArRasIu3qEFAIgIRRvTVqpEF6Tv_1bUi-cS3M-SIsWc1Q2Uj5OWV4yjmJv8GTqFolqFCeMTaRNjAmzPIE8yUPJrTHVHiBPCdyi7L4LE-AbzQHMf_JVO_vJQZaCk4-EbfDFJUCHFFdfLprDYG-vsVwCNIdL8CO_1Ul2tihGLuZh19_3sWZLG3Uev_VWo0oKynN0bDBXUEUgW12te9fKFIg4R6TJJ-5M_oDPsatjEea1GhS0_QyLG2rkC-7fuJzdfEVvLMUdFAmRikA3iX3Fdxmk_zQ33sfWu5w_05mxG-E_YvBAZr9N9Lnh9jcjXwcERLuuYCV6i6jmxd1mXD6MS_FWJIdhL4jMsrN_jtecbwZmOe95oJvPNG0RK9-CP1A4VzUDraokDfHZQHaVVAGmm4WJYXY4xWtZ34MUo3AlGDqiiBMffqgM7m1I35AyZHbWSlS7qwieFhHKtN7snpQW_pCFd9UpPVrwminpHsUgpWHqBHyo1zaiEhPjwNivAQ1ArobhWalGuClD8tqx2RKFktjfB7PAFqB-pGwOnViP_fcbC4oW95EQn_X70sDx-GupCw4fNYxEon3uI49iD8hHFTsoEoEC7tq39QltVaW2nDy1JKTvaX9toje7ZVy9_OojpAHjD9KVTuHKfDa3feukq0RNJVT7hYoDCwtTXKXih--adKtretNJUeU0XJ7NLLhj7I5tAa-UyiZk3DUQY2gHkkjnY03DPApZgCHt2qWs3hQYE7kSLpKdomdVRPzrxCv6VQk-WKtUz5a_e2OFrgs-adb_VY8hi0HaZcPExH34tYDfXzepxTZkHRGrcF8Zkkj-lWuHZTpBIaA7T6XAJL4bgJjEejwt7-oQ8Iu0PyV11FoZFsSvuKM-CXaVkC9dY77LTf5_jskDQL2iQ6FWYou5v4JjAvDn7e8tE1txdVi77_noEMGIKKpRQkUTA2rPp8wzqpfturtz2NHC0U8FTn0nZO6mXswGnkowW62F_FqxJ_CF89wiZFPv_Fbmjxg0V9soqmHI0T34zjAsVUQsFUmCdQ; LastSearchDate=%7B%22date%22%3A%2203.12.2019%22%7D; AMP_TOKEN=%24NOT_FOUND; LastSearchInfo=%7B%22RoomsCount%22%3A447%2C%22Type%22%3A127%2C%22TypeOfSearchComplexOrEstate%22%3A1%2C%22priceFrom%22%3Anull%2C%22priceTo%22%3Anull%2C%22cityName%22%3A%22%D0%92%D1%81%D0%B5%20%D0%B3%D0%BE%D1%80%D0%BE%D0%B4%D0%B0%22%2C%22AdminUnitsId%22%3A%5B1%5D%2C%22Sort%22%3A1%2C%22SortDirection%22%3A1%2C%22PricePerSquareMeterFrom%22%3Anull%2C%22PricePerSquareMeterTo%22%3Anull%2C%22TagIds%22%3Anull%2C%22sizeFrom%22%3Anull%2C%22sizeTo%22%3Anull%2C%22InstallmentPlan%22%3Afalse%2C%22Promotion%22%3Anull%2C%22AdministrativeUnitType%22%3A1%2C%22ApartmentType%22%3A15%2C%22RoomsAndHalfRoomsCount%22%3A0%2C%22FloorsString%22%3Anull%2C%22ConstructionStatus%22%3A0%2C%22Parking%22%3A31%2C%22BathRoomsCount%22%3A127%2C%22HasLift%22%3Afalse%7D; LinkToLastSearch=https%3A%2F%2Flocalhost%3A5001%2Fprojects%3FSort%3DFeatured%26SortDirection%3DDescending%26TypeOfSearchComplexOrEstate%3D1%26currency%3DTRY%26page%3D1%26AdminUnitsId%3D1%26AdministrativeUnitType%3D1%26Type%3D127%26RoomsCount%3D447%26BathRoomsCount%3D127%26Parking%3D31%26ApartmentType%3D15%26ConstructionStatus%3D0%26HasLift%3DFalse%26InstallmentPlan%3DFalse; UserSearchId=592347; _gw=2.u%5B%2C%2C%2C%2C%5Dv%5B~fmrde%2C~0%2C~1%5Da(18255-140076161~93yj)","Host":"localhost:5001","Referer":"https://localhost:5001/projects","User-Agent":"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/78.0.3904.108 Safari/537.36","Origin":"https://localhost:5001","Content-Length":"83","X-Requested-With":"XMLHttpRequest","Sec-Fetch-Site":"same-origin","Sec-Fetch-Mode":"cors"},"http_version":"1.1","method":"POST","socket":{"encrypted":true,"remote_address":"::1"},"url":{"full":"https://localhost:5001/api/saveusernavigation","hostname":"localhost","pathname":"/api/saveusernavigation","protocol":"HTTP","raw":"https://localhost:5001/api/saveusernavigation","search":""}},"response":{"finished":true,"headers":{"date":"Tue, 03 Dec 2019 10:31:49 GMT","transfer-Encoding":"chunked","content-Type":"application/json; charset=utf-8","content-Encoding":"gzip","server":"Kestrel","set-Cookie":"LastSearchInfo=%7B%22RoomsCount%22%3A447%2C%22Type%22%3A127%2C%22TypeOfSearchComplexOrEstate%22%3A1%2C%22priceFrom%22%3Anull%2C%22priceTo%22%3Anull%2C%22cityName%22%3A%22%D0%92%D1%81%D0%B5%20%D0%B3%D0%BE%D1%80%D0%BE%D0%B4%D0%B0%22%2C%22AdminUnitsId%22%3A%5B1%5D%2C%22Sort%22%3A1%2C%22SortDirection%22%3A1%2C%22PricePerSquareMeterFrom%22%3Anull%2C%22PricePerSquareMeterTo%22%3Anull%2C%22TagIds%22%3Anull%2C%22sizeFrom%22%3Anull%2C%22sizeTo%22%3Anull%2C%22InstallmentPlan%22%3Afalse%2C%22Promotion%22%3Anull%2C%22AdministrativeUnitType%22%3A1%2C%22ApartmentType%22%3A15%2C%22RoomsAndHalfRoomsCount%22%3A0%2C%22FloorsString%22%3Anull%2C%22ConstructionStatus%22%3A0%2C%22Parking%22%3A31%2C%22BathRoomsCount%22%3A127%2C%22HasLift%22%3Afalse%7D; expires=Thu, 03 Dec 2020 10:31:49 GMT; path=/; samesite=lax","vary":"Accept-Encoding","access-Control-Allow-Origin":"*","x-Frame-Options":"ALLOW-FROM "},"status_code":200}},"duration":20.678,"id":"c21aff5e5aa7d545","sampled":true,"name":"POST RecommendationApi/SaveUserNavigationAsync","result":"HTTP 2xx","span_count":{"dropped":0,"started":0},"timestamp":1575369109295041,"trace_id":"5be66fef6ad7c928f071083029fefcd7","type":"request"}
trce: Elastic.Apm[0]

sergo · December 3, 2019, 11:12am

> trce: Elastic.Apm[0]
>       {PayloadSenderV2} Serialized item to send: Elastic.Apm.Metrics.MetricSet as {"samples":{"system.memory.actual.free":{"value":2231402496.0},"system.memory.total":{"value":16568758272.0},"system.process.memory.size":{"value":2222247055360.0},"system.process.memory.rss.bytes":{"value":869830656.0},"system.cpu.total.norm.pct":{"value":0.82788528442382814},"system.process.cpu.total.norm.pct":{"value":0.12706508204378877}},"timestamp":1575369110205778}
> trce: Elastic.Apm[0]
>       {HttpDiagnosticListenerImplBase} Called with key: `System.Net.Http.HttpRequestOut.Start'
> trce: Elastic.Apm[0]
>       {HttpDiagnosticListenerImplBase} Request URL (http://127.0.0.1:8200/intake/v2/events) is filtered out - exiting
> trce: Elastic.Apm[0]
>       {HttpDiagnosticListenerImplBase} Called with key: `System.Net.Http.Request'
> trce: Elastic.Apm[0]
>       {HttpDiagnosticListenerImplBase} Request URL (http://127.0.0.1:8200/intake/v2/events) is filtered out - exiting
> trce: Elastic.Apm[0]
>       {SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Finished executing task. Task: ID: 98, Status: RanToCompletion, AsyncState: System.Action}
> trce: Elastic.Apm[0]
>       {HttpDiagnosticListenerImplBase} Called with key: `System.Net.Http.HttpRequestOut.Stop'
> trce: Elastic.Apm[0]
>       {HttpDiagnosticListenerImplBase} Request URL (http://127.0.0.1:8200/intake/v2/events) is filtered out - exiting
> trce: Elastic.Apm[0]
>       {HttpDiagnosticListenerImplBase} Called with key: `System.Net.Http.Response'
> trce: Elastic.Apm[0]
>       {HttpDiagnosticListenerImplBase} Event's Request property is null - exiting
> trce: Elastic.Apm[0]
>       {SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Trying to execute task inline... Task: ID: 101, Status: WaitingToRun, AsyncState: System.Action}, taskWasPreviouslyQueued: False
> trce: Elastic.Apm[0]
>       {SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Adding task... Task: ID: 101, Status: WaitingToRun, AsyncState: System.Action}
> trce: Elastic.Apm[0]
>       {SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Added task. Task: ID: 101, Status: WaitingToRun, AsyncState: System.Action}
> trce: Elastic.Apm[0]
>       {SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Starting to execute task... Task: ID: 101, Status: WaitingToRun, AsyncState: System.Action}
> dbug: Elastic.Apm[0]
>       {PayloadSenderV2} Sent items to server:
>     Transaction{Id: 784bf67517a0b675, TraceId: 44cca718816d01977bdb74dc29f80b26, ParentId: null, Name: GET /Static/build/desktop/index20191203103148.js, Type: request, IsSampled: True},
>           Transaction{Id: 99d1fa005da5323f, TraceId: 8d1d4e3ba86ad39597f9083df7537514, ParentId: null, Name: GET /Static/build/desktop/index20191203103148.css, Type: request, IsSampled: True},
>           Transaction{Id: 58ded59313fe40d3, TraceId: cc32a59a5cc2d17a9fadb970b665e551, ParentId: null, Name: GET /Static/build/desktop/LayoutBundle20191203103148.js, Type: request, IsSampled: True},
>           Transaction{Id: 906e3b5b75642cdd, TraceId: 337841d499bf54030e70abce63e7ddd3, ParentId: null, Name: GET /Static/build/desktop/EstateSearchBundle20191203103148.js, Type: request, IsSampled: True},
>           Elastic.Apm.Metrics.MetricSet,
>           Transaction{Id: c21aff5e5aa7d545, TraceId: 5be66fef6ad7c928f071083029fefcd7, ParentId: null, Name: POST RecommendationApi/SaveUserNavigationAsync, Type: request, IsSampled: True},
>           Transaction{Id: 5c691fcee4ad64a4, TraceId: 098d25bd6ec2b82b2faaddf566631428, ParentId: null, Name: GET UserApi/GetChatInfo, Type: request, IsSampled: True},
>           Transaction{Id: 88eb6306a5eca59b, TraceId: 42a02077f17b56b7f707c626d64b3311, ParentId: null, Name: GET Developer/BackToSearch, Type: request, IsSampled: True},
>           Transaction{Id: bfefc834313949eb, TraceId: 9d204a1a3a5592f22085b394c152e7ff, ParentId: null, Name: GET SearchApi/Developers, Type: request, IsSampled: True},
>           Elastic.Apm.Metrics.MetricSet
> trce: Elastic.Apm[0]
>       {SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Trying to execute task inline... Task: ID: 102, Status: WaitingToRun, AsyncState: System.Action}, taskWasPreviouslyQueued: False
> trce: Elastic.Apm[0]
>       {SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Trying to execute task inline... Task: ID: 103, Status: WaitingToRun, AsyncState: System.Action}, taskWasPreviouslyQueued: False
> trce: Elastic.Apm[0]
>       {PayloadSenderV2} Waiting for data to send... FlushInterval: 10s
> trce: Elastic.Apm[0]
>       {SingleThreadTaskScheduler (thread: ElasticApmPayloadSenderV2)} Finished executing task. Task: ID: 101, Status: RanToCompletion, AsyncState: System.Action}
> info: Microsoft.EntityFrameworkCore.Database.Command[20101]
>       Executed DbCommand (5ms) [Parameters=[@p0='?' (Size = 4000), @p1='?' (DbType = Int32), @p2='?' (DbType = Int32), @p3='?' (DbType = Int32), @p4='?' (DbType = Int32), @p5='?' (DbType = Int32), @p6='?' (Size = 4000), @p7='?' (DbType = Int32), @p8='?' (DbType = Int32), @p9='?' (DbType = Boolean), @p10='?' (DbType = Int32), @p11='?' (DbType = Boolean), @p12='?' (Size = 128), @p13='?' (Size = 4000), @p14='?' (DbType = Int32), @p15='?' (DbType = Boolean), @p16='?' (DbType = Int32), @p17='?' (DbType = Int32), @p18='?' (DbType = Boolean), @p19='?' (DbType = Boolean), @p20='?' (DbType = Double), @p21='?' (DbType = Double), @p22='?' (DbType = Boolean), @p23='?' (DbType = Boolean), @p24='?' (DbType = Int32), @p25='?' (DbType = Int32), @p26='?' (DbType = Int64), @p27='?' (DbType = Int64), @p28='?' (DbType = Int64), @p29='?' (DbType = Int64), @p30='?' (DbType = Int32), @p31='?' (DbType = Boolean), @p32='?' (DbType = Int32), @p33='?' (DbType = Int32), @p34='?' (DbType = Int32), @p35='?' (Size = 4000), @p36='?' (DbType = Guid), @p37='?' (Size = 4000), @p38='?' (DbType = DateTime), @p39='?' (DbType = Int32), @p40='?' (DbType = Int32), @p41='?' (DbType = Int32), @p42='?' (DbType = Int32), @p43='?' (Size = 4000), @p44='?' (Size = 4000), @p45='?' (Size = 4000), @p46='?' (Size = 4000), @p47='?' (DbType = Double), @p48='?' (DbType = Double), @p49='?' (Size = 4000), @p50='?' (DbType = Int32), @p51='?' (DbType = Int32), @p52='?' (DbType = Int32), @p53='?' (DbType = Boolean)], CommandType='Text', CommandTimeout='3600']
>       SET NOCOUNT ON;
>       INSERT INTO [dat].[UserSearches] ([AdminUnitIds], [AdministrativeUnitType_Id], [BathRoomsCount], [CommissioningMonth], [CommissioningQuarter], [CommissioningYear], [ComplexTagIds], [ConstructionStatus], [Device], [HasLift], [Heating], [HeatingMeter], [HomstersUserId], [HumanFriendlySearchFor], [IndoorFinish], [InstallmentPlan], [IsItLegalized], [Level], [MilitaryMortgage], [Mortgage], [NeLat], [NeLng], [OptionToBuyGarage], [OptionToBuyParkingSpace], [Page], [Parking], [PriceFrom], [PricePerSquareMeterFrom], [PricePerSquareMeterTo], [PriceTo], [ProjectsCount], [Promotion], [ResidentialClass], [RoomsCount], [RoomsWithLivingRoomsCount], [SearchFor], [SearchId], [SearchRequest], [SearchTime], [SizeFrom], [SizeTo], [Sort], [SortDirection], [SortingName], [SortingResults], [SortingVersion], [SuggestSearchFor], [SwLat], [SwLng], [Tags], [Type], [TypeOfHouse], [ViewFromTheWindow], [WithPhoto])
>       VALUES (@p0, @p1, @p2, @p3, @p4, @p5, @p6, @p7, @p8, @p9, @p10, @p11, @p12, @p13, @p14, @p15, @p16, @p17, @p18, @p19, @p20, @p21, @p22, @p23, @p24, @p25, @p26, @p27, @p28, @p29, @p30, @p31, @p32, @p33, @p34, @p35, @p36, @p37, @p38, @p39, @p40, @p41, @p42, @p43, @p44, @p45, @p46, @p47, @p48, @p49, @p50, @p51, @p52, @p53);
>       SELECT [Id]
>       FROM [dat].[UserSearches]
>       WHERE @@ROWCOUNT = 1 AND [Id] = scope_identity();

GregKalapos · December 3, 2019, 11:27am

@sergo this is interesting... your logs start with

Transaction{Id: a4052e86a8a6b0a9, TraceId: 9067995a65ce838ba3fb79b350659937, ParentId: null, Name: POST /api/search/saveusersearch, Type: request, IsSampled: True}

That is the 1. print of the current transaction - before the DB call.

Then we have some things about the transaction and HTTP calll.

Then the db Call - which is your last line:

info: Microsoft.EntityFrameworkCore.Database.Command[20101]
>       Executed DbCommand (5ms) [Parameters=[@p0='?' (Size
...

And then nothing else - did you also print the current transaction right after the db call in the same method?

Thinking more about my log line, it was maybe not that smart - what I wanted to make sure is that the current transaction is not null and it's the same before and after the db call.

So, something like this would be better - especially after the db call:

if(Agent.Tracer.CurrentTransaction == null)
  Console.WriteLine("No Current Transaction");
else
  Console.WriteLine(Agent.Tracer.CurrentTransaction.ToString());

Otherwise .ToString() throws a nullrefexception. Did you see an exception (caused by my additional logging).

If we are sure that there is not active transaction right after the db call, then that what I should look into more.

sergo · December 3, 2019, 1:36pm

dear @GregKalapos
I collected data before my transaction and after it. I mark this in the log data
before start-transction:
and
after start-transction:
please see maybe it help to analize.
Thank you for your help
before start-transction:
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
Executed action Homsters.Web.Controllers.API.SearchApiController.Developers (Homsters.Web.Core) in 172.2011ms
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
Executing action method Homsters.Web.Controllers.API.SearchApiController.SaveUserSearch (Homsters.Web.Core) with arguments (Homsters.Models.UserSearchModel) - Validation state: Valid
dbug: Elastic.Apm[0]
{PayloadSenderV2} Enqueued Transaction. newEventQueueCount: 9. MaxQueueEventCount: 1000. Transaction: Transaction{Id: 9eccda534dbb131c, TraceId: c466225ff60af37c002a44b430806dc6, ParentId: null, Name: GET SearchApi/Developers, Type: request, IsSampled: True}.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Request finished in 447.3027ms 200 application/json; charset=utf-8
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 GET http://abudhabi.localhost:5000/personal
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://abudhabi.localhost:5000/profiler/results application/json 45
dbug: Elastic.Apm[0]
{PayloadSenderV2} Enqueued MetricSet. newEventQueueCount: 10. MaxQueueEventCount: 1000. MetricSet: Elastic.Apm.Metrics.MetricSet.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://abudhabi.localhost:5000/profiler/results application/json 45
dbug: Elastic.Apm[0]
{ApmMiddleware} Incoming request. Starting Trace.
dbug: Elastic.Apm[0]
{MetricsCollector} Metrics collected: MetricSample{system.memory.actual.free: 2449948672}, MetricSample{system.memory.total: 16568758272}, MetricSample{system.process.memory.size: 2222282948608}, MetricSample{system.process.memory.rss.bytes: 1171046400}, MetricSample{system.cpu.total.norm.pct: 0.352083740234375}, MetricSample{system.process.cpu.total.norm.pct: 0.00476249243323479}
dbug: Elastic.Apm[0]
{AbstractConfigurationReader (MicrosoftExtensionsConfig)} Using provided transaction sample rate `1' parsed as 1
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://abudhabi.localhost:5000/profiler/results application/json 45
dbug: Elastic.Apm[0]
{Tracer} Starting Transaction{Id: acecf245b8f1ba1c, TraceId: ec4687efa698a937d78273819e2aaf90, ParentId: null, Name: GET /personal, Type: request, IsSampled: True}
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
Route matched with {action = "Personal", controller = "ReactClient", page = "", area = ""}. Executing action Homsters.Web.Controllers.ReactClientController.Personal (Homsters.Web.Core)
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[1]
Executing action method Homsters.Web.Controllers.ReactClientController.Personal (Homsters.Web.Core) - Validation state: Valid
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
Executed action method Homsters.Web.Controllers.ReactClientController.Personal (Homsters.Web.Core), returned result Microsoft.AspNetCore.Mvc.ViewResult in 0.026ms.
info: Microsoft.AspNetCore.Mvc.ViewFeatures.ViewResultExecutor[1]
Executing ViewResult, running view Index.
info: Microsoft.AspNetCore.Mvc.ViewFeatures.ViewResultExecutor[4]
Executed ViewResult - view Index executed in 11.5633ms.
info: Microsoft.AspNetCore.Mvc.Internal.ControllerActionInvoker[2]
Executed action Homsters.Web.Controllers.ReactClientController.Personal (Homsters.Web.Core) in 35.1939ms
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Request finished in 137.3737ms 200 application/json
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Request finished in 207.8977ms 200 application/json
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://abudhabi.localhost:5000/profiler/results application/json 45
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Request finished in 422.7925ms 200 application/json
--------------------------
after start-transction:
info: Microsoft.EntityFrameworkCore.Database.Command[20101]
Executed DbCommand (396ms) [Parameters=[@__id_0='?' (DbType = Int64)], CommandType='Text', CommandTimeout='3600']
SELECT TOP(1) [search].[Id], [search].[AdminUnitIds], [search].[AdministrativeUnitType_Id], [search].[BathRoomsCount], [search].[CommissioningMonth], [search].[CommissioningQuarter], [search].[CommissioningYear], [search].[ComplexTagIds], [search].[ConstructionStatus], [search].[Device], [search].[HasLift], [search].[Heating], [search].[HeatingMeter], [search].[HomstersUserId], [search].[HumanFriendlySearchFor], [search].[IndoorFinish], [search].[InstallmentPlan], [search].[IsItLegalized], [search].[Level], [search].[MilitaryMortgage], [search].[Mortgage], [search].[NeLat], [search].[NeLng], [search].[OptionToBuyGarage], [search].[OptionToBuyParkingSpace], [search].[Page], [search].[Parking], [search].[PriceFrom], [search].[PricePerSquareMeterFrom], [search].[PricePerSquareMeterTo], [search].[PriceTo], [search].[ProjectsCount], [search].[Promotion], [search].[ResidentialClass], [search].[RoomsCount], [search].[RoomsWithLivingRoomsCount], [search].[SearchFor], [search].[SearchId], [search].[SearchRequest], [search].[SearchTime], [search].[SizeFrom], [search].[SizeTo], [search].[Sort], [search].[SortDirection], [search].[SortingName], [search].[SortingResults], [search].[SortingVersion], [search].[SuggestSearchFor], [search].[SwLat], [search].[SwLng], [search].[Tags], [search].[Type], [search].[TypeOfHouse], [search].[ViewFromTheWindow], [search].[WithPhoto]
FROM [dat].[UserSearches] AS [search]
WHERE [search].[Id] = @__id_0
info: System.Net.Http.HttpClient.Default.ClientHandler[101]
Received HTTP response after 108142.9336ms - OK
info: System.Net.Http.HttpClient.Default.LogicalHandler[101]
End processing HTTP request after 108167.3974ms - OK
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Request finished in 9.4278ms 200 application/json
dbug: Elastic.Apm[0]
{PayloadSenderV2} Enqueued Transaction. newEventQueueCount: 2. MaxQueueEventCount: 1000. Transaction: Transaction{Id: acecf245b8f1ba1c, TraceId: ec4687efa698a937d78273819e2aaf90, ParentId: null, Name: GET ReactClient/Personal, Type: request, IsSampled: True}.
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Request finished in 518.4428ms 200 text/html; charset=utf-8
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://abudhabi.localhost:5000/profiler/results application/json 45
dbug: Elastic.Apm[0]
{PayloadSenderV2} Sent items to server:
Elastic.Apm.Metrics.MetricSet,
Transaction{Id: 19bd922293dec2fd, TraceId: aeb8e23b9f7fa3a95c816228d7ef8762, ParentId: null, Name: GET /Static/build/desktop/index20191203012233.js, Type: request, IsSampled: True},
Transaction{Id: 385b242e31a5e3d1, TraceId: 700b6c913d9c977275e96b54d50114af, ParentId: null, Name: GET /Static/build/desktop/LayoutBundle20191203012233.js, Type: request, IsSampled: True},
Transaction{Id: 5fb058efe3c29d76, TraceId: 24916834a30dbbe63722e055eb2bcd27, ParentId: null, Name: GET /Static/build/desktop/EstateSearchBundle20191203012233.js, Type: request, IsSampled: True},
Transaction{Id: 55a373b11777a7cf, TraceId: dde25118c74e5f89d6e2a58354fbdda9, ParentId: null, Name: POST RecommendationApi/SaveUserNavigationAsync, Type: request, IsSampled: True},
Transaction{Id: dd8a8b3fd8498fa6, TraceId: e55cb29834229ce759b190bdf4dfd3ac, ParentId: null, Name: GET UserApi/GetChatInfo, Type: request, IsSampled: True},
Transaction{Id: 1b4cc84fd6d5c976, TraceId: a386e51330d926a8c04fe83ef18cca51, ParentId: null, Name: GET Developer/BackToSearch, Type: request, IsSampled: True},
Elastic.Apm.Metrics.MetricSet,
Transaction{Id: 9eccda534dbb131c, TraceId: c466225ff60af37c002a44b430806dc6, ParentId: null, Name: GET SearchApi/Developers, Type: request, IsSampled: True}
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://abudhabi.localhost:5000/profiler/results application/json 45
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Request finished in 73266.0396ms 200 application/json
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[2]
Request finished in 17.8277ms 200 application/json
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://abudhabi.localhost:5000/profiler/results application/json 45
info: Microsoft.AspNetCore.Hosting.Internal.WebHost[1]
Request starting HTTP/1.1 POST http://abudhabi.localhost:5000/profiler/results application/json 45

sergo · December 3, 2019, 3:51pm

Dear @GregKalapos, i checked and don't have Agent.Tracker.Current Transaction == null)

GregKalapos · December 4, 2019, 2:06pm

Hi @sergo,
the logs are strange - Did you add the log lines to manually print the transaction? I'm not sure I see that. So you say, the current transaction is not null? We should make sure that it's the same before and after the db call.

Is this app available opensource, or would it be possible to give us a minimal reproducer? That would make debugging easier - if not we can continue trying with the logs, this is just an idea to make progress easier.

system · December 25, 2019, 10:06am

This topic was automatically closed 20 days after the last reply. New replies are no longer allowed.