Skip to content

Azure functions in powershell #3300

New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom
Closed
ghost opened this issue Apr 20, 2021 · 6 comments
Closed

Azure functions in powershell #3300

ghost opened this issue Apr 20, 2021 · 6 comments
Labels
Resolution-Inactive Will close automatically.

Comments

@ghost
Copy link

ghost commented Apr 20, 2021

Debugger will not attach when attempting to run Azure Functions locally. Debugging works with plain old powershell scripts.
@ghost ghost added the Needs: Triage Maintainer attention needed! label Apr 20, 2021
@SydneyhSmith
Copy link
Collaborator

Thanks @avacoder could you please provide more detailed reproduction steps, as well as any appropriate GIFs or images that can describe what you are experiencing, as well as version details and it would be really helpful if you could also attach the logs--instructions for how to do that are here

@SydneyhSmith SydneyhSmith added Needs-Repro-Info and removed Needs: Triage Maintainer attention needed! labels Apr 20, 2021
@HoLengZai
Copy link

HoLengZai commented Apr 21, 2021 •
edited
Loading

Hi @SydneyhSmith,
I got a similar behaviour as @avacoder but I post it in vscode-azurefunctions, I don't know on which GitHub project i should post my issue.
microsoft/vscode-azurefunctions#2776

My project works normally in VSCode PowerShell project and I can debug without any issue, warning or whatever
My issue is when I move my PowerShell code in an Azure Function PowerShell even when the Azure Function is performing nothing I got an error with the Debugger, breakpoints work sometimes and my program doesn't work as expected.

@ghost ghost added the Needs: Maintainer Attention Maintainer attention needed! label Apr 21, 2021
@ghost
Copy link
Author

ghost commented Apr 21, 2021 via email •
edited by rjmholt
Loading

@rjmholt
Copy link
Contributor

rjmholt commented Apr 27, 2021

Reformat of @avacoder's comment:

Hi Sydney,

PFA the three log files generated.

The output of the ‘code -v’ command is:

1.55.2

3c4e3df9e89829dce27b7b5c24508306b151f30d

x64

Ever since my system ran a Windows update yesterday, the console no longer displays Write-Host output…and I have a lot of Write-Host statements in the function

I am using the add-in ‘Azure Functions for Visual Studio Code’ version 1.3.0

My system is running Powershell version 7.1.3

Below is the output of the task host window when I run the function (F5):

Azure Functions Core Tools

Core Tools Version:       3.0.3442 Commit hash: 6bfab24b2743f8421475d996402c398d2fe4a9e0  (64-bit)

Function Runtime Version: 3.0.15417.0



[2021-04-21T14:25:34.404Z] Starting Rpc Initialization Service.

[2021-04-21T14:25:34.408Z] Initializing RpcServer

[2021-04-21T14:25:34.421Z] RpcServer initialized

[2021-04-21T14:25:34.424Z] Rpc Initialization Service started.

[2021-04-21T14:25:34.430Z] Startup operation 'da6bafa7-d3f6-477e-9f9a-de56b9f1787e' with parent id '(null)' created.

[2021-04-21T14:25:34.434Z] Startup operation 'da6bafa7-d3f6-477e-9f9a-de56b9f1787e' starting.

[2021-04-21T14:25:34.439Z] Building host: startup suppressed: 'False', configuration suppressed: 'False', startup operation id: 'da6bafa7-d3f6-477e-9f9a-de56b9f1787e'

[2021-04-21T14:25:34.501Z] Host configuration applied.

[2021-04-21T14:25:34.504Z] Reading host configuration file 'C:\Users\jt.pierce\OneDrive - Avanade\source\repos\IT-AutomationIntegration\UtilityFunctions\host.json'

[2021-04-21T14:25:34.506Z] Host configuration file read:

[2021-04-21T14:25:34.510Z] {

[2021-04-21T14:25:34.514Z]   "version": "2.0",

[2021-04-21T14:25:34.517Z]   "logging": {

[2021-04-21T14:25:34.518Z]     "logLevel": {

[2021-04-21T14:25:34.519Z]       "Functions.VerifyResourceGroupAssets": "Debug",

[2021-04-21T14:25:34.520Z]       "default": "Debug"

[2021-04-21T14:25:34.521Z]     },

[2021-04-21T14:25:34.523Z]     "console": {

[2021-04-21T14:25:34.526Z]       "isEnabled": "true"

[2021-04-21T14:25:34.528Z]     }

[2021-04-21T14:25:34.529Z]   },

[2021-04-21T14:25:34.533Z]   "extensionBundle": {

[2021-04-21T14:25:34.534Z]     "id": "Microsoft.Azure.Functions.ExtensionBundle",

[2021-04-21T14:25:34.536Z]     "version": "[1.*, 2.0.0)"

[2021-04-21T14:25:34.537Z]   }

[2021-04-21T14:25:34.538Z] }

[2021-04-21T14:25:34.565Z] Loading functions metadata

[2021-04-21T14:25:34.567Z] Workers Directory set to: C:\Program Files\Microsoft\Azure Functions Core Tools\workers

[2021-04-21T14:25:34.569Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\java\worker.config.json

[2021-04-21T14:25:34.614Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:34.616Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:java

[2021-04-21T14:25:34.617Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\node\worker.config.json

[2021-04-21T14:25:34.633Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:34.634Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:node

[2021-04-21T14:25:34.636Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\powershell\worker.config.json

[2021-04-21T14:25:34.650Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:34.652Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME_VERSION: ~7

[2021-04-21T14:25:34.661Z] Added WorkerConfig for language: powershell

[2021-04-21T14:25:34.666Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\python\worker.config.json

[2021-04-21T14:25:34.684Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:34.685Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:python

[2021-04-21T14:25:34.688Z] Reading functions metadata

[2021-04-21T14:25:34.719Z] 6 functions found

[2021-04-21T14:25:34.738Z] 6 functions loaded

[2021-04-21T14:25:34.747Z] Looking for extension bundle Microsoft.Azure.Functions.ExtensionBundle at C:\Users\jt.pierce\.azure-functions-core-tools\Functions\ExtensionBundles\Microsoft.Azure.Functions.ExtensionBundle

[2021-04-21T14:25:34.751Z] Found a matching extension bundle at C:\Users\jt.pierce\.azure-functions-core-tools\Functions\ExtensionBundles\Microsoft.Azure.Functions.ExtensionBundle\1.5.1

[2021-04-21T14:25:34.754Z] Fetching information on versions of extension bundle Microsoft.Azure.Functions.ExtensionBundle available on https://functionscdn.azureedge.net/public/ExtensionBundles/Microsoft.Azure.Functions.ExtensionBundle/index.json

[2021-04-21T14:25:35.026Z] Skipping bundle download since it already exists at path C:\Users\jt.pierce\.azure-functions-core-tools\Functions\ExtensionBundles\Microsoft.Azure.Functions.ExtensionBundle\1.5.1

[2021-04-21T14:25:35.033Z] Loading extension bundle from C:\Users\jt.pierce\.azure-functions-core-tools\Functions\ExtensionBundles\Microsoft.Azure.Functions.ExtensionBundle\1.5.1\bin

[2021-04-21T14:25:35.071Z] Host configuration applied.

[2021-04-21T14:25:35.078Z] Reading host configuration file 'C:\Users\jt.pierce\OneDrive - Avanade\source\repos\IT-AutomationIntegration\UtilityFunctions\host.json'

[2021-04-21T14:25:35.080Z] Host configuration file read:

[2021-04-21T14:25:35.081Z] {

[2021-04-21T14:25:35.084Z]   "version": "2.0",

[2021-04-21T14:25:35.085Z]   "logging": {

[2021-04-21T14:25:35.086Z]     "logLevel": {

[2021-04-21T14:25:35.088Z]       "Functions.VerifyResourceGroupAssets": "Debug",

[2021-04-21T14:25:35.093Z]       "default": "Debug"

[2021-04-21T14:25:35.097Z]     },

[2021-04-21T14:25:35.099Z]     "console": {

[2021-04-21T14:25:35.100Z]       "isEnabled": "true"

[2021-04-21T14:25:35.101Z]     }

[2021-04-21T14:25:35.104Z]   },

[2021-04-21T14:25:35.105Z]   "extensionBundle": {

[2021-04-21T14:25:35.112Z]     "id": "Microsoft.Azure.Functions.ExtensionBundle",

[2021-04-21T14:25:35.119Z]     "version": "[1.*, 2.0.0)"

[2021-04-21T14:25:35.120Z]   }

[2021-04-21T14:25:35.124Z] }

[2021-04-21T14:25:35.518Z] Active host changing from '(null)' to '25d723f4-fb93-45b5-bf29-af1c74480fbe'.

[2021-04-21T14:25:35.727Z] Workers Directory set to: C:\Program Files\Microsoft\Azure Functions Core Tools\workers

[2021-04-21T14:25:35.730Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\java\worker.config.json

[2021-04-21T14:25:35.732Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:35.734Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:java

[2021-04-21T14:25:35.736Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\node\worker.config.json

[2021-04-21T14:25:35.740Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:35.742Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:node

[2021-04-21T14:25:35.744Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\powershell\worker.config.json

[2021-04-21T14:25:35.746Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:35.749Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME_VERSION: ~7

[2021-04-21T14:25:35.751Z] Added WorkerConfig for language: powershell

[2021-04-21T14:25:35.753Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\python\worker.config.json

[2021-04-21T14:25:35.757Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:35.759Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:python

[2021-04-21T14:25:36.044Z] Initializing Warmup Extension.

[2021-04-21T14:25:36.118Z] Initializing Host. OperationId: 'da6bafa7-d3f6-477e-9f9a-de56b9f1787e'.

[2021-04-21T14:25:36.146Z] Host initialization: ConsecutiveErrors=0, StartupCount=1, OperationId=da6bafa7-d3f6-477e-9f9a-de56b9f1787e

[2021-04-21T14:25:36.165Z] Startup operation 'da6bafa7-d3f6-477e-9f9a-de56b9f1787e' is starting host instance '25d723f4-fb93-45b5-bf29-af1c74480fbe'.

[2021-04-21T14:25:36.168Z] Hosting starting

[2021-04-21T14:25:36.217Z] LoggerFilterOptions

[2021-04-21T14:25:36.219Z] {

[2021-04-21T14:25:36.233Z]   "MinLevel": "None",

[2021-04-21T14:25:36.234Z]   "Rules": [

[2021-04-21T14:25:36.235Z]     {

[2021-04-21T14:25:36.244Z]       "ProviderName": null,

[2021-04-21T14:25:36.246Z]       "CategoryName": null,

[2021-04-21T14:25:36.247Z]       "LogLevel": null,

[2021-04-21T14:25:36.249Z]       "Filter": "<AddFilter>b__0"

[2021-04-21T14:25:36.251Z]     },

[2021-04-21T14:25:36.258Z]     {

[2021-04-21T14:25:36.263Z]       "ProviderName": null,

[2021-04-21T14:25:36.265Z]       "CategoryName": "Functions.VerifyResourceGroupAssets",

[2021-04-21T14:25:36.266Z]       "LogLevel": "Debug",

[2021-04-21T14:25:36.268Z]       "Filter": null

[2021-04-21T14:25:36.279Z]     },

[2021-04-21T14:25:36.281Z]     {

[2021-04-21T14:25:36.282Z]       "ProviderName": null,

[2021-04-21T14:25:36.284Z]       "CategoryName": null,

[2021-04-21T14:25:36.285Z]       "LogLevel": "Debug",

[2021-04-21T14:25:36.297Z]       "Filter": null

[2021-04-21T14:25:36.299Z]     },

[2021-04-21T14:25:36.301Z]     {

[2021-04-21T14:25:36.302Z]       "ProviderName": "Microsoft.Azure.WebJobs.Script.WebHost.Diagnostics.SystemLoggerProvider",

[2021-04-21T14:25:36.310Z]       "CategoryName": null,

[2021-04-21T14:25:36.313Z]       "LogLevel": "None",

[2021-04-21T14:25:36.315Z]       "Filter": null

[2021-04-21T14:25:36.317Z]     },

[2021-04-21T14:25:36.318Z]     {

[2021-04-21T14:25:36.327Z]       "ProviderName": "Microsoft.Azure.WebJobs.Script.WebHost.Diagnostics.SystemLoggerProvider",

[2021-04-21T14:25:36.330Z]       "CategoryName": null,

[2021-04-21T14:25:36.332Z]       "LogLevel": null,

[2021-04-21T14:25:36.347Z]       "Filter": "<AddFilter>b__0"

[2021-04-21T14:25:36.350Z]     },

[2021-04-21T14:25:36.358Z]     {

[2021-04-21T14:25:36.361Z]       "ProviderName": "Azure.Functions.Cli.Diagnostics.ColoredConsoleLoggerProvider",

[2021-04-21T14:25:36.364Z]       "CategoryName": null,

[2021-04-21T14:25:36.368Z]       "LogLevel": null,

[2021-04-21T14:25:36.378Z]       "Filter": "<AddFilter>b__0"

[2021-04-21T14:25:36.395Z]     }

[2021-04-21T14:25:36.399Z]   ]

[2021-04-21T14:25:36.410Z] }

[2021-04-21T14:25:36.418Z] LoggerFilterOptions

[2021-04-21T14:25:36.424Z] {

[2021-04-21T14:25:36.431Z]   "MinLevel": "None",

[2021-04-21T14:25:36.433Z]   "Rules": [

[2021-04-21T14:25:36.434Z]     {

[2021-04-21T14:25:36.436Z]       "ProviderName": null,

[2021-04-21T14:25:36.448Z]       "CategoryName": null,

[2021-04-21T14:25:36.451Z]       "LogLevel": null,

[2021-04-21T14:25:36.458Z]       "Filter": "<AddFilter>b__0"

[2021-04-21T14:25:36.466Z]     },

[2021-04-21T14:25:36.468Z]     {

[2021-04-21T14:25:36.478Z]       "ProviderName": null,

[2021-04-21T14:25:36.480Z]       "CategoryName": "Functions.VerifyResourceGroupAssets",

[2021-04-21T14:25:36.482Z]       "LogLevel": "Debug",

[2021-04-21T14:25:36.484Z]       "Filter": null

[2021-04-21T14:25:36.490Z]     },

[2021-04-21T14:25:36.496Z]     {

[2021-04-21T14:25:36.497Z]       "ProviderName": null,

[2021-04-21T14:25:36.499Z]       "CategoryName": null,

[2021-04-21T14:25:36.500Z]       "LogLevel": "Debug",

[2021-04-21T14:25:36.502Z]       "Filter": null

[2021-04-21T14:25:36.512Z]     },

[2021-04-21T14:25:36.514Z]     {

[2021-04-21T14:25:36.515Z]       "ProviderName": "Microsoft.Azure.WebJobs.Script.WebHost.Diagnostics.SystemLoggerProvider",

[2021-04-21T14:25:36.518Z]       "CategoryName": null,

[2021-04-21T14:25:36.521Z]       "LogLevel": "None",

[2021-04-21T14:25:36.530Z]       "Filter": null

[2021-04-21T14:25:36.532Z]     },

[2021-04-21T14:25:36.536Z]     {

[2021-04-21T14:25:36.548Z]       "ProviderName": "Microsoft.Azure.WebJobs.Script.WebHost.Diagnostics.SystemLoggerProvider",

[2021-04-21T14:25:36.550Z]       "CategoryName": null,

[2021-04-21T14:25:36.552Z]       "LogLevel": null,

[2021-04-21T14:25:36.564Z]       "Filter": "<AddFilter>b__0"

[2021-04-21T14:25:36.566Z]     },

[2021-04-21T14:25:36.567Z]     {

[2021-04-21T14:25:36.568Z]       "ProviderName": "Azure.Functions.Cli.Diagnostics.ColoredConsoleLoggerProvider",

[2021-04-21T14:25:36.581Z]       "CategoryName": null,

[2021-04-21T14:25:36.584Z]       "LogLevel": null,

[2021-04-21T14:25:36.585Z]       "Filter": "<AddFilter>b__0"

[2021-04-21T14:25:36.595Z]     }

[2021-04-21T14:25:36.596Z]   ]

[2021-04-21T14:25:36.598Z] }

[2021-04-21T14:25:36.601Z] FunctionResultAggregatorOptions

[2021-04-21T14:25:36.602Z] {

[2021-04-21T14:25:36.611Z]   "BatchSize": 1000,

[2021-04-21T14:25:36.613Z]   "FlushTimeout": "00:00:30",

[2021-04-21T14:25:36.615Z]   "IsEnabled": true

[2021-04-21T14:25:36.616Z] }

[2021-04-21T14:25:36.627Z] SingletonOptions

[2021-04-21T14:25:36.629Z] {

[2021-04-21T14:25:36.630Z]   "LockPeriod": "00:00:15",

[2021-04-21T14:25:36.632Z]   "ListenerLockPeriod": "00:00:15",

[2021-04-21T14:25:36.636Z]   "LockAcquisitionTimeout": "10675199.02:48:05.4775807",

[2021-04-21T14:25:36.646Z]   "LockAcquisitionPollingInterval": "00:00:05",

[2021-04-21T14:25:36.649Z]   "ListenerLockRecoveryPollingInterval": "00:01:00"

[2021-04-21T14:25:36.659Z] }

[2021-04-21T14:25:36.662Z] HttpOptions

[2021-04-21T14:25:36.664Z] {

[2021-04-21T14:25:36.665Z]   "DynamicThrottlesEnabled": false,

[2021-04-21T14:25:36.668Z]   "MaxConcurrentRequests": -1,

[2021-04-21T14:25:36.675Z]   "MaxOutstandingRequests": -1,

[2021-04-21T14:25:36.678Z]   "RoutePrefix": "api"

[2021-04-21T14:25:36.680Z] }

[2021-04-21T14:25:36.696Z] Starting JobHost

[2021-04-21T14:25:36.710Z] Starting Host (HostId=win8ffsquvonu-874168845, InstanceId=25d723f4-fb93-45b5-bf29-af1c74480fbe, Version=3.0.15417.0, ProcessId=23096, AppDomainId=1, InDebugMode=False, InDiagnosticMode=False, FunctionsExtensionVersion=(null))

[2021-04-21T14:25:36.757Z] Loading functions metadata

[2021-04-21T14:25:36.764Z] Workers Directory set to: C:\Program Files\Microsoft\Azure Functions Core Tools\workers

[2021-04-21T14:25:36.767Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\java\worker.config.json

[2021-04-21T14:25:36.771Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:36.777Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:java

[2021-04-21T14:25:36.783Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\node\worker.config.json

[2021-04-21T14:25:36.797Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:36.800Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:node

[2021-04-21T14:25:36.807Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\powershell\worker.config.json

[2021-04-21T14:25:36.823Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:36.830Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME_VERSION: ~7

[2021-04-21T14:25:36.833Z] Added WorkerConfig for language: powershell

[2021-04-21T14:25:36.866Z] Found worker config: C:\Program Files\Microsoft\Azure Functions Core Tools\workers\python\worker.config.json

[2021-04-21T14:25:36.874Z] EnvironmentVariable FUNCTIONS_WORKER_RUNTIME: powershell

[2021-04-21T14:25:36.882Z] FUNCTIONS_WORKER_RUNTIME set to powershell. Skipping WorkerConfig for language:python

[2021-04-21T14:25:36.933Z] Loading proxies metadata

[2021-04-21T14:25:37.112Z] Initializing Azure Function proxies

[2021-04-21T14:25:37.529Z] 0 proxies loaded

[2021-04-21T14:25:37.550Z] 6 functions loaded

[2021-04-21T14:25:37.563Z] Adding Function descriptor provider for language powershell.

[2021-04-21T14:25:37.566Z] Creating function descriptors.

[2021-04-21T14:25:37.632Z] Function descriptors created.

[2021-04-21T14:25:37.648Z] Setting up FunctionInvocationBuffer for function:Get-DuplicateSubnets with functionId:ed017d8b-6ac2-44c7-9ef4-f415d0fc9ac0

[2021-04-21T14:25:37.650Z] Setting up FunctionInvocationBuffer for function:GetResourceGroupAuditHistory with functionId:2018c30b-d252-482b-9a4a-110799f6c8f7

[2021-04-21T14:25:37.661Z] Setting up FunctionInvocationBuffer for function:NotifyWebhookExpiration with functionId:39568700-ae29-4429-b8f3-a3503da05add

[2021-04-21T14:25:37.663Z] Setting up FunctionInvocationBuffer for function:RenewServiceConnectionAppCredentials with functionId:84e570d4-8e7c-464f-a047-e42483569d38[2021-04-21T14:25:37.664Z] Setting up FunctionInvocationBuffer for function:ReportResourceGroupAssets with functionId:d8e17872-48b4-4d8f-8805-d0092174e049

[2021-04-21T14:25:37.666Z] Setting up FunctionInvocationBuffer for function:VerifyResourceGroupAssets with functionId:9764067f-8e8c-467d-9264-c9c0caf0cf37

[2021-04-21T14:25:37.679Z] Initiating Worker Process start up

[2021-04-21T14:25:37.693Z] Starting worker process with FileName:C:\Program Files\dotnet\dotnet.exe WorkingDirectory:C:\Users\jt.pierce\OneDrive - Avanade\source\repos\IT-AutomationIntegration\UtilityFunctions Arguments: "C:\Program Files\Microsoft\Azure Functions Core Tools\workers\powershell\7/Microsoft.Azure.Functions.PowerShellWorker.dll" --host 127.0.0.1 --port 4994 --workerId 4f20f126-b761-4ef7-8d68-878d04549d66 --requestId 1f2c9490-4390-4253-85f0-aba4398dc00d --grpcMaxMessageLength 2147483647

[2021-04-21T14:25:37.980Z] C:\Program Files\dotnet\dotnet.exe process with Id=22504 started

[2021-04-21T14:25:37.987Z] Generating 6 job function(s)

[2021-04-21T14:25:38.061Z] Found the following functions:

[2021-04-21T14:25:38.074Z] Host.Functions.Get-DuplicateSubnets

[2021-04-21T14:25:38.078Z] Host.Functions.GetResourceGroupAuditHistory

[2021-04-21T14:25:38.080Z] Host.Functions.NotifyWebhookExpiration

[2021-04-21T14:25:38.082Z] Host.Functions.RenewServiceConnectionAppCredentials

[2021-04-21T14:25:38.131Z] Host.Functions.ReportResourceGroupAssets

[2021-04-21T14:25:38.163Z] Host.Functions.VerifyResourceGroupAssets

[2021-04-21T14:25:38.166Z]

[2021-04-21T14:25:38.197Z] Initializing function HTTP routes

[2021-04-21T14:25:38.209Z] Mapped function route 'api/Get-DuplicateSubnets' [get] to 'Get-DuplicateSubnets'

[2021-04-21T14:25:38.211Z] Mapped function route 'api/GetResourceGroupAuditHistory' [get] to 'GetResourceGroupAuditHistory'

[2021-04-21T14:25:38.212Z] Mapped function route 'api/RenewServiceConnectionAppCredentials' [get,post] to 'RenewServiceConnectionAppCredentials'

[2021-04-21T14:25:38.214Z] Mapped function route 'api/ReportResourceGroupAssets' [get] to 'ReportResourceGroupAssets'

[2021-04-21T14:25:38.218Z] Mapped function route 'api/VerifyResourceGroupAssets' [get] to 'VerifyResourceGroupAssets'

[2021-04-21T14:25:38.225Z]

[2021-04-21T14:25:38.248Z] Host initialized (1515ms)

[2021-04-21T14:25:38.262Z] Singleton lock acquired (win8ffsquvonu-874168845/Host.Functions.NotifyWebhookExpiration.Listener)

[2021-04-21T14:25:38.307Z] The 'NotifyWebhookExpiration' timer is using the schedule 'Cron: '0 0 0 * * *'' and the local time zone: '(UTC-05:00) Eastern Time (US & Canada)'

[2021-04-21T14:25:38.395Z] The listener for function 'Functions.NotifyWebhookExpiration' was unable to start.

[2021-04-21T14:25:38.407Z] The listener for function 'Functions.NotifyWebhookExpiration' was unable to start. Microsoft.Azure.Storage.Common: No valid combination of account information found.

[2021-04-21T14:25:38.465Z] Host started (1752ms)

[2021-04-21T14:25:38.473Z] Job host started

[2021-04-21T14:25:38.481Z] File event source initialized.

[2021-04-21T14:25:38.496Z] Debug file watch initialized.

[2021-04-21T14:25:38.499Z] Diagnostic file watch initialized.

[2021-04-21T14:25:38.511Z] Hosting started

[2021-04-21T14:25:38.526Z] Startup operation 'da6bafa7-d3f6-477e-9f9a-de56b9f1787e' completed.



Functions:



        Get-DuplicateSubnets: [GET] http://localhost:7071/api/Get-DuplicateSubnets



        GetResourceGroupAuditHistory: [GET] http://localhost:7071/api/GetResourceGroupAuditHistory



        RenewServiceConnectionAppCredentials: [GET,POST] http://localhost:7071/api/RenewServiceConnectionAppCredentials



        ReportResourceGroupAssets: [GET] http://localhost:7071/api/ReportResourceGroupAssets



        VerifyResourceGroupAssets: [GET] http://localhost:7071/api/VerifyResourceGroupAssets



        NotifyWebhookExpiration: timerTrigger



For detailed output, run func with --verbose flag.

[2021-04-21T14:25:38.941Z] System Log: { Log-Level: Information; Log-Message: Azure Functions PowerShell Worker version [3.0.629.0]. }

[2021-04-21T14:25:40.279Z] System Log: { Log-Level: Information; Log-Message: PowerShell version: '7.0.3'. }

[2021-04-21T14:25:40.487Z] Retrying to start listener for function 'Functions.NotifyWebhookExpiration' (Attempt 1)

[2021-04-21T14:25:40.490Z] Unable to acquire Singleton lock (win8ffsquvonu-874168845/Host.Functions.NotifyWebhookExpiration.Listener).

[2021-04-21T14:25:40.492Z] Listener successfully started for function 'Functions.NotifyWebhookExpiration' after 1 retries.

[2021-04-21T14:25:40.667Z] System Log: { Log-Level: Information; Log-Message: The enforced concurrency level (pool size limit) is '10'. }

[2021-04-21T14:25:40.698Z] Established RPC channel. WorkerId: 4f20f126-b761-4ef7-8d68-878d04549d66

[2021-04-21T14:25:40.702Z] Worker Process started. Received StartStream message

[2021-04-21T14:25:40.760Z] System Log: { Log-Level: Trace; Log-Message: Custom pipe name specified. You can attach to the process by using vscode or by running `Enter-PSHostProcess -CustomPipeName AzureFunctionsPSWorker` }

[2021-04-21T14:25:40.804Z] Received WorkerInitResponse. Worker process initialized

[2021-04-21T14:25:40.822Z] Worker capabilities: { "RpcHttpBodyOnly": "true" }

[2021-04-21T14:25:40.825Z] Updating capabilities: { "RpcHttpBodyOnly": "true" }

[2021-04-21T14:25:40.831Z] Adding jobhost language worker channel for runtime: powershell. workerId:4f20f126-b761-4ef7-8d68-878d04549d66

[2021-04-21T14:25:40.843Z] Sending FunctionLoadRequest for function:Get-DuplicateSubnets with functionId:ed017d8b-6ac2-44c7-9ef4-f415d0fc9ac0

[2021-04-21T14:25:40.852Z] Adding dependency download request to powershell language worker

[2021-04-21T14:25:40.857Z] Sending FunctionLoadRequest for function:GetResourceGroupAuditHistory with functionId:2018c30b-d252-482b-9a4a-110799f6c8f7

[2021-04-21T14:25:40.859Z] Adding dependency download request to powershell language worker

[2021-04-21T14:25:40.877Z] Sending FunctionLoadRequest for function:NotifyWebhookExpiration with functionId:39568700-ae29-4429-b8f3-a3503da05add

[2021-04-21T14:25:40.892Z] Adding dependency download request to powershell language worker

[2021-04-21T14:25:40.894Z] Sending FunctionLoadRequest for function:RenewServiceConnectionAppCredentials with functionId:84e570d4-8e7c-464f-a047-e42483569d38

[2021-04-21T14:25:40.900Z] Adding dependency download request to powershell language worker

[2021-04-21T14:25:40.907Z] Sending FunctionLoadRequest for function:ReportResourceGroupAssets with functionId:d8e17872-48b4-4d8f-8805-d0092174e049

[2021-04-21T14:25:40.909Z] Adding dependency download request to powershell language worker

[2021-04-21T14:25:40.914Z] Sending FunctionLoadRequest for function:VerifyResourceGroupAssets with functionId:9764067f-8e8c-467d-9264-c9c0caf0cf37

[2021-04-21T14:25:40.922Z] Adding dependency download request to powershell language worker

[2021-04-21T14:25:40.924Z] Worker process started and initialized.

[2021-04-21T14:25:40.975Z] System Log: { Log-Level: Trace; Log-Message: Updating dependencies folder heartbeat for 'C:\Users\jt.pierce\AppData\Local\AzureFunctions\UtilityFunctions\ManagedDependencies\210409171842709.r''. }

[2021-04-21T14:25:41.013Z] System Log: { Log-Level: Trace; Log-Message: First function load request completed in 134 ms. }

[2021-04-21T14:25:41.022Z] System Log: { Log-Level: Trace; Log-Message: The function app has existing dependencies installed. Updating the dependencies to the latest versions will be performed in the background. New function app instances will pick up any new dependencies. }

[2021-04-21T14:25:41.143Z] Received FunctionLoadResponse for functionId:ed017d8b-6ac2-44c7-9ef4-f415d0fc9ac0

[2021-04-21T14:25:41.275Z] Received FunctionLoadResponse for functionId:2018c30b-d252-482b-9a4a-110799f6c8f7

[2021-04-21T14:25:41.283Z] Received FunctionLoadResponse for functionId:39568700-ae29-4429-b8f3-a3503da05add

[2021-04-21T14:25:41.372Z] Received FunctionLoadResponse for functionId:84e570d4-8e7c-464f-a047-e42483569d38

[2021-04-21T14:25:41.391Z] Received FunctionLoadResponse for functionId:d8e17872-48b4-4d8f-8805-d0092174e049

[2021-04-21T14:25:41.428Z] Received FunctionLoadResponse for functionId:9764067f-8e8c-467d-9264-c9c0caf0cf37

[2021-04-21T14:25:43.479Z] Host lock lease acquired by instance ID '00000000000000000000000074D3F107'.

@SydneyhSmith
Copy link
Collaborator

Thanks @avacoder could you please also provide what version of the PowerShell extension you are using?

@SydneyhSmith SydneyhSmith removed the Needs: Maintainer Attention Maintainer attention needed! label Apr 27, 2021
@ghost
Copy link

ghost commented May 12, 2021

This issue is being closed as inactive, if this issue is still occurring it will be re-opened

@ghost ghost added the Resolution-Inactive Will close automatically. label May 12, 2021
@ghost ghost closed this as completed May 12, 2021
This issue was closed.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
Resolution-Inactive Will close automatically.
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@rjmholt @HoLengZai @SydneyhSmith