Python Function app: works locally, but can not deploy

Johan Holm 5 Reputation points
2023-03-09T15:31:24.44+00:00

I am trying to deploy my function app from VS Code and I managed to get it to work on a test function app. But the actual one is a nightmare to get working. Usually it just fails at syncing triggers until it fails. Sometimes it creates a function called "warmup" which is nowhere in my code.

I have added the AzureWebJobsFeatureFlags:EnableWorkerIndexing to the settings as suggested elsewhere. It did not help. It manages to upload the files. So they are available in the "App Files" on the portal, but it doesn't work. I don't know what to do.

Here is the output I get when I try to deploy:

4:10:24 PM aktivitetsproduktivitetsrapport: Starting deployment...
4:10:24 PM aktivitetsproduktivitetsrapport: Creating zip package...
4:10:24 PM aktivitetsproduktivitetsrapport: Zip package size: 9.3 kB
4:10:27 PM aktivitetsproduktivitetsrapport: Fetching changes.
4:10:28 PM aktivitetsproduktivitetsrapport: Cleaning up temp folders from previous zip deployments and extracting pushed zip file /tmp/zipdeploy/d7b0580f-f79a-4e8d-8c3d-93e387fbadab.zip (0.01 MB) to /tmp/zipdeploy/extracted
4:10:30 PM aktivitetsproduktivitetsrapport: Updating submodules.
4:10:31 PM aktivitetsproduktivitetsrapport: Preparing deployment for commit id '148f59e1-b'.
4:10:31 PM aktivitetsproduktivitetsrapport: PreDeployment: context.CleanOutputPath False
4:10:31 PM aktivitetsproduktivitetsrapport: PreDeployment: context.OutputPath /home/site/wwwroot
4:10:31 PM aktivitetsproduktivitetsrapport: Repository path is /tmp/zipdeploy/extracted
4:10:31 PM aktivitetsproduktivitetsrapport: Running oryx build...
4:10:31 PM aktivitetsproduktivitetsrapport: Command: oryx build /tmp/zipdeploy/extracted -o /home/site/wwwroot --platform python --platform-version 3.10.4 -p packagedir=.python_packages/lib/site-packages
4:10:33 PM aktivitetsproduktivitetsrapport: Operation performed by Microsoft Oryx, https://github.com/Microsoft/Oryx
4:10:33 PM aktivitetsproduktivitetsrapport: You can report issues at https://github.com/Microsoft/Oryx/issues
4:10:33 PM aktivitetsproduktivitetsrapport: Oryx Version: 0.2.20220815.2, Commit: 35e9c4851aba1f7b9c0516dbd202084022e653f2, ReleaseTagName: 20220815.2
4:10:33 PM aktivitetsproduktivitetsrapport: Build Operation ID: |qpWG9yo+9lU=.b48a0a79_
4:10:33 PM aktivitetsproduktivitetsrapport: Repository Commit : 148f59e1-b642-46b7-b0c0-af4c54a42bb4
4:10:33 PM aktivitetsproduktivitetsrapport: Detecting platforms...
4:10:34 PM aktivitetsproduktivitetsrapport: Detected following platforms:
4:10:34 PM aktivitetsproduktivitetsrapport:   python: 3.10.4
4:10:34 PM aktivitetsproduktivitetsrapport: Version '3.10.4' of platform 'python' is not installed. Generating script to install it...
4:10:34 PM aktivitetsproduktivitetsrapport: Source directory     : /tmp/zipdeploy/extracted
4:10:34 PM aktivitetsproduktivitetsrapport: Destination directory: /home/site/wwwroot
4:10:34 PM aktivitetsproduktivitetsrapport: Downloading and extracting 'python' version '3.10.4' to '/tmp/oryx/platforms/python/3.10.4'...
4:10:34 PM aktivitetsproduktivitetsrapport: Detecting image debian flavor: bullseye.
4:10:35 PM aktivitetsproduktivitetsrapport: Downloaded in 1 sec(s).
4:10:35 PM aktivitetsproduktivitetsrapport: Verifying checksum...
4:10:35 PM aktivitetsproduktivitetsrapport: Extracting contents...
4:10:38 PM aktivitetsproduktivitetsrapport: performing sha512 checksum for: python...
4:10:38 PM aktivitetsproduktivitetsrapport: Done in 4 sec(s).
4:10:38 PM aktivitetsproduktivitetsrapport: Python Version: /tmp/oryx/platforms/python/3.10.4/bin/python3.10
4:10:38 PM aktivitetsproduktivitetsrapport: Creating directory for command manifest file if it does not exist
4:10:38 PM aktivitetsproduktivitetsrapport: Removing existing manifest file
4:10:38 PM aktivitetsproduktivitetsrapport: Running pip install...
4:11:06 PM aktivitetsproduktivitetsrapport: Done in 28 sec(s).
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:39+0000] Collecting azure-common==1.1.28
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:39+0000]   Downloading azure_common-1.1.28-py2.py3-none-any.whl (14 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:39+0000] Collecting azure-core==1.26.3
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:39+0000]   Downloading azure_core-1.26.3-py3-none-any.whl (174 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:40+0000] Collecting azure-functions==1.13.3
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:40+0000]   Downloading azure_functions-1.13.3-py3-none-any.whl (163 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:40+0000] Collecting certifi==2022.12.7
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:40+0000]   Downloading certifi-2022.12.7-py3-none-any.whl (155 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:41+0000] Collecting cffi==1.15.1
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:41+0000]   Downloading cffi-1.15.1-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (441 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:41+0000] Collecting charset-normalizer==3.1.0
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:41+0000]   Downloading charset_normalizer-3.1.0-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (199 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:42+0000] Collecting cryptography==39.0.2
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:42+0000]   Downloading cryptography-39.0.2-cp36-abi3-manylinux_2_28_x86_64.whl (4.2 MB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000] Collecting greenlet==2.0.2
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000]   Downloading greenlet-2.0.2-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (613 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000] Collecting idna==3.4
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000]   Downloading idna-3.4-py3-none-any.whl (61 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000] Collecting isodate==0.6.1
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000]   Downloading isodate-0.6.1-py2.py3-none-any.whl (41 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000] Collecting msal==1.21.0
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000]   Downloading msal-1.21.0-py2.py3-none-any.whl (89 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000] Collecting msal-extensions==1.0.0
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000]   Downloading msal_extensions-1.0.0-py2.py3-none-any.whl (19 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000] Collecting msrest==0.7.1
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:43+0000]   Downloading msrest-0.7.1-py3-none-any.whl (85 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:44+0000] Collecting numpy==1.24.2
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:44+0000]   Downloading numpy-1.24.2-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (17.3 MB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:45+0000] Collecting oauthlib==3.2.2
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:45+0000]   Downloading oauthlib-3.2.2-py3-none-any.whl (151 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:46+0000] Collecting pandas==1.5.3
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:46+0000]   Downloading pandas-1.5.3-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (12.1 MB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:46+0000] Collecting portalocker==2.7.0
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:46+0000]   Downloading portalocker-2.7.0-py2.py3-none-any.whl (15 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:46+0000] Collecting pycparser==2.21
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:46+0000]   Downloading pycparser-2.21-py2.py3-none-any.whl (118 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:47+0000] Collecting PyJWT==2.6.0
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:47+0000]   Downloading PyJWT-2.6.0-py3-none-any.whl (20 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:47+0000] Collecting pyodbc==4.0.35
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:47+0000]   Downloading pyodbc-4.0.35-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (332 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:47+0000] Collecting python-dateutil==2.8.2
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:47+0000]   Downloading python_dateutil-2.8.2-py2.py3-none-any.whl (247 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:47+0000] Collecting pytz==2022.7.1
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:47+0000]   Downloading pytz-2022.7.1-py2.py3-none-any.whl (499 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:48+0000] Collecting requests==2.28.2
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:48+0000]   Downloading requests-2.28.2-py3-none-any.whl (62 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:48+0000] Collecting requests-oauthlib==1.3.1
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:48+0000]   Downloading requests_oauthlib-1.3.1-py2.py3-none-any.whl (23 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:48+0000] Collecting six==1.16.0
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:48+0000]   Downloading six-1.16.0-py2.py3-none-any.whl (11 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:49+0000] Collecting SQLAlchemy==2.0.5.post1
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:49+0000]   Downloading SQLAlchemy-2.0.5.post1-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (2.7 MB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:49+0000] Collecting typing_extensions==4.5.0
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:49+0000]   Downloading typing_extensions-4.5.0-py3-none-any.whl (27 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:49+0000] Collecting urllib3==1.26.14
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:50+0000]   Downloading urllib3-1.26.14-py2.py3-none-any.whl (140 kB)
4:11:06 PM aktivitetsproduktivitetsrapport: [15:10:51+0000] Installing collected packages: pycparser, cffi, urllib3, PyJWT, idna, cryptography, charset-normalizer, certifi, typing-extensions, six, requests, oauthlib, requests-oauthlib, pytz, python-dateutil, portalocker, numpy, msal, isodate, greenlet, azure-core, SQLAlchemy, pyodbc, pandas, msrest, msal-extensions, azure-functions, azure-common
4:11:06 PM aktivitetsproduktivitetsrapport: [15:11:05+0000] Successfully installed PyJWT-2.6.0 SQLAlchemy-2.0.5.post1 azure-common-1.1.28 azure-core-1.26.3 azure-functions-1.13.3 certifi-2022.12.7 cffi-1.15.1 charset-normalizer-3.1.0 cryptography-39.0.2 greenlet-2.0.2 idna-3.4 isodate-0.6.1 msal-1.21.0 msal-extensions-1.0.0 msrest-0.7.1 numpy-1.24.2 oauthlib-3.2.2 pandas-1.5.3 portalocker-2.7.0 pycparser-2.21 pyodbc-4.0.35 python-dateutil-2.8.2 pytz-2022.7.1 requests-2.28.2 requests-oauthlib-1.3.1 six-1.16.0 typing-extensions-4.5.0 urllib3-1.26.14
4:11:06 PM aktivitetsproduktivitetsrapport: WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
4:11:06 PM aktivitetsproduktivitetsrapport: WARNING: You are using pip version 21.2.4; however, version 23.0.1 is available.
4:11:06 PM aktivitetsproduktivitetsrapport: You should consider upgrading via the '/tmp/oryx/platforms/python/3.10.4/bin/python3.10 -m pip install --upgrade pip' command.
4:11:06 PM aktivitetsproduktivitetsrapport: Not a vso image, so not writing build commands
4:11:06 PM aktivitetsproduktivitetsrapport: Preparing output...
4:11:06 PM aktivitetsproduktivitetsrapport: Copying files to destination directory '/home/site/wwwroot'...
4:11:08 PM aktivitetsproduktivitetsrapport: Done in 2 sec(s).
4:11:08 PM aktivitetsproduktivitetsrapport: Removing existing manifest file
4:11:08 PM aktivitetsproduktivitetsrapport: Creating a manifest file...
4:11:08 PM aktivitetsproduktivitetsrapport: Manifest file created.
4:11:08 PM aktivitetsproduktivitetsrapport: Copying .ostype to manifest output directory.
4:11:08 PM aktivitetsproduktivitetsrapport: Done in 34 sec(s).
4:11:08 PM aktivitetsproduktivitetsrapport: Running post deployment command(s)...
4:11:08 PM aktivitetsproduktivitetsrapport: Generating summary of Oryx build
4:11:08 PM aktivitetsproduktivitetsrapport: Deployment Log file does not exist in /tmp/oryx-build.log
4:11:08 PM aktivitetsproduktivitetsrapport: The logfile at /tmp/oryx-build.log is empty. Unable to fetch the summary of build
4:11:08 PM aktivitetsproduktivitetsrapport: Triggering recycle (preview mode disabled).
4:11:08 PM aktivitetsproduktivitetsrapport: Linux Consumption plan has a 1.5 GB memory limit on a remote build container.
4:11:08 PM aktivitetsproduktivitetsrapport: To check our service limit, please visit https://docs.microsoft.com/en-us/azure/azure-functions/functions-scale#service-limits
4:11:08 PM aktivitetsproduktivitetsrapport: Writing the artifacts to a squashfs file
4:11:20 PM aktivitetsproduktivitetsrapport: Parallel mksquashfs: Using 1 processor
4:11:20 PM aktivitetsproduktivitetsrapport: Creating 4.0 filesystem on /home/site/artifacts/functionappartifact.squashfs, block size 131072.
4:11:41 PM aktivitetsproduktivitetsrapport: [==================/                                           ] 2200/7274  30%
4:11:42 PM aktivitetsproduktivitetsrapport: [=============================================================\] 7274/7274 100%
4:11:42 PM aktivitetsproduktivitetsrapport: Exportable Squashfs 4.0 filesystem, gzip compressed, data block size 131072
4:11:42 PM aktivitetsproduktivitetsrapport: 	compressed data, compressed metadata, compressed fragments,
4:11:42 PM aktivitetsproduktivitetsrapport: 	compressed xattrs, compressed ids
4:11:42 PM aktivitetsproduktivitetsrapport: 	duplicates are removed
4:11:42 PM aktivitetsproduktivitetsrapport: Filesystem size 49581.19 Kbytes (48.42 Mbytes)
4:11:42 PM aktivitetsproduktivitetsrapport: 	29.81% of uncompressed filesystem size (166341.25 Kbytes)
4:11:42 PM aktivitetsproduktivitetsrapport: Inode table size 69777 bytes (68.14 Kbytes)
4:11:42 PM aktivitetsproduktivitetsrapport: 	28.93% of uncompressed inode table size (241184 bytes)
4:11:42 PM aktivitetsproduktivitetsrapport: Directory table size 71624 bytes (69.95 Kbytes)
4:11:42 PM aktivitetsproduktivitetsrapport: 	35.78% of uncompressed directory table size (200203 bytes)
4:11:42 PM aktivitetsproduktivitetsrapport: Number of duplicate files found 461
4:11:42 PM aktivitetsproduktivitetsrapport: Number of inodes 7433
4:11:42 PM aktivitetsproduktivitetsrapport: Number of files 6732
4:11:42 PM aktivitetsproduktivitetsrapport: Number of fragments 639
4:11:42 PM aktivitetsproduktivitetsrapport: Number of symbolic links  0
4:11:42 PM aktivitetsproduktivitetsrapport: Number of device nodes 0
4:11:42 PM aktivitetsproduktivitetsrapport: Number of fifo nodes 0
4:11:42 PM aktivitetsproduktivitetsrapport: Number of socket nodes 0
4:11:42 PM aktivitetsproduktivitetsrapport: Number of directories 701
4:11:42 PM aktivitetsproduktivitetsrapport: Number of ids (unique uids + gids) 1
4:11:42 PM aktivitetsproduktivitetsrapport: Number of uids 1
4:11:42 PM aktivitetsproduktivitetsrapport: 	root (0)
4:11:42 PM aktivitetsproduktivitetsrapport: Number of gids 1
4:11:42 PM aktivitetsproduktivitetsrapport: 	root (0)
4:11:42 PM aktivitetsproduktivitetsrapport: Creating placeholder blob for linux consumption function app...
4:11:42 PM aktivitetsproduktivitetsrapport: SCM_RUN_FROM_PACKAGE placeholder blob scm-latest-aktivitetsproduktivitetsrapport.zip located
4:11:42 PM aktivitetsproduktivitetsrapport: Uploading built content /home/site/artifacts/functionappartifact.squashfs for linux consumption function app...
4:11:43 PM aktivitetsproduktivitetsrapport: Resetting all workers for aktivitetsproduktivitetsrapport.azurewebsites.net
4:11:43 PM aktivitetsproduktivitetsrapport: Deployment successful. deployer = ms-azuretools-vscode deploymentPath = Functions App ZipDeploy. Extract zip. Remote build.
4:11:59 PM aktivitetsproduktivitetsrapport: Syncing triggers...
4:12:31 PM aktivitetsproduktivitetsrapport: Syncing triggers (Attempt 2/6)...
4:12:42 PM aktivitetsproduktivitetsrapport: Syncing triggers (Attempt 3/6)...
4:13:02 PM aktivitetsproduktivitetsrapport: Syncing triggers (Attempt 4/6)...
4:13:45 PM aktivitetsproduktivitetsrapport: Syncing triggers (Attempt 5/6)...
4:15:05 PM aktivitetsproduktivitetsrapport: Syncing triggers (Attempt 6/6)...
4:15:06 PM: Error: Encountered an error (InternalServerError) from host runtime.
Azure Functions
Azure Functions
An Azure service that provides an event-driven serverless compute platform.
4,264 questions
{count} vote

1 answer

Sort by: Most helpful
  1. Johan Holm 5 Reputation points
    2023-03-16T06:28:27.3033333+00:00

    I found the issue. The issue was a firewall issue. I was able to connect to a database locally, but not from the function app. So the problem got fixed by making sure that the function app also had network access to the database.

    I solved it by having a simple hello-world function app and kept adding things to it until it also failed.