2024-02-08T13:48:43.5642054Z Requested labels: ubuntu-20.04
2024-02-08T13:48:43.5642395Z Job defined at: solaluset/pwcp/.github/workflows/ci.yml@refs/heads/rename
2024-02-08T13:48:43.5642538Z Waiting for a runner to pick up this job...
2024-02-08T13:48:43.8012678Z Job is waiting for a hosted runner to come online.
2024-02-08T13:48:46.4748508Z Job is about to start running on the hosted runner: GitHub Actions 5 (hosted)
2024-02-08T13:48:48.8876465Z Current runner version: '2.312.0'
2024-02-08T13:48:48.8898668Z ##[group]Operating System
2024-02-08T13:48:48.8899272Z Ubuntu
2024-02-08T13:48:48.8899577Z 20.04.6
2024-02-08T13:48:48.8899875Z LTS
2024-02-08T13:48:48.8900176Z ##[endgroup]
2024-02-08T13:48:48.8900513Z ##[group]Runner Image
2024-02-08T13:48:48.8900907Z Image: ubuntu-20.04
2024-02-08T13:48:48.8901275Z Version: 20240204.1.0
2024-02-08T13:48:48.8902236Z Included Software: https://github.com/actions/runner-images/blob/ubuntu20/20240204.1/images/ubuntu/Ubuntu2004-Readme.md
2024-02-08T13:48:48.8903623Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu20%2F20240204.1
2024-02-08T13:48:48.8904463Z ##[endgroup]
2024-02-08T13:48:48.8904827Z ##[group]Runner Image Provisioner
2024-02-08T13:48:48.8905260Z 2.0.341.1
2024-02-08T13:48:48.8905580Z ##[endgroup]
2024-02-08T13:48:48.8907664Z ##[group]GITHUB_TOKEN Permissions
2024-02-08T13:48:48.8909221Z Actions: write
2024-02-08T13:48:48.8909614Z Checks: write
2024-02-08T13:48:48.8910116Z Contents: write
2024-02-08T13:48:48.8910525Z Deployments: write
2024-02-08T13:48:48.8910908Z Discussions: write
2024-02-08T13:48:48.8911264Z Issues: write
2024-02-08T13:48:48.8911594Z Metadata: read
2024-02-08T13:48:48.8911928Z Packages: write
2024-02-08T13:48:48.8912292Z Pages: write
2024-02-08T13:48:48.8912626Z PullRequests: write
2024-02-08T13:48:48.8913004Z RepositoryProjects: write
2024-02-08T13:48:48.8913430Z SecurityEvents: write
2024-02-08T13:48:48.8913799Z Statuses: write
2024-02-08T13:48:48.8914128Z ##[endgroup]
2024-02-08T13:48:48.8917148Z Secret source: Actions
2024-02-08T13:48:48.8917687Z Prepare workflow directory
2024-02-08T13:48:48.9525427Z Prepare all required actions
2024-02-08T13:48:48.9679374Z Getting action download info
2024-02-08T13:48:49.2378073Z Download action repository 'actions/checkout@v2' (SHA:ee0669bd1cc54295c223e0bb666b733df41de1c5)
2024-02-08T13:48:49.3264541Z Download action repository 'actions/setup-python@v2' (SHA:e9aba2c848f5ebd159c070c61ea2c4e2b122355e)
2024-02-08T13:48:49.4754372Z Complete job name: Test (3.11)
2024-02-08T13:48:49.5810802Z ##[group]Run actions/checkout@v2
2024-02-08T13:48:49.5811439Z with:
2024-02-08T13:48:49.5811884Z   repository: solaluset/pwcp
2024-02-08T13:48:49.5812563Z   token: ***
2024-02-08T13:48:49.5812942Z   ssh-strict: true
2024-02-08T13:48:49.5813384Z   persist-credentials: true
2024-02-08T13:48:49.5813810Z   clean: true
2024-02-08T13:48:49.5814156Z   fetch-depth: 1
2024-02-08T13:48:49.5814538Z   lfs: false
2024-02-08T13:48:49.5814863Z   submodules: false
2024-02-08T13:48:49.5815257Z   set-safe-directory: true
2024-02-08T13:48:49.5815713Z ##[endgroup]
2024-02-08T13:48:49.7447643Z Syncing repository: solaluset/pwcp
2024-02-08T13:48:49.7449748Z ##[group]Getting Git version info
2024-02-08T13:48:49.7450559Z Working directory is '/home/runner/work/pwcp/pwcp'
2024-02-08T13:48:49.7451600Z [command]/usr/bin/git version
2024-02-08T13:48:49.7452083Z git version 2.43.0
2024-02-08T13:48:49.7459606Z ##[endgroup]
2024-02-08T13:48:49.7479475Z Temporarily overriding HOME='/home/runner/work/_temp/65cbeb2b-13ec-432b-9b0b-09bcb06adf6a' before making global git config changes
2024-02-08T13:48:49.7482300Z Adding repository directory to the temporary git global config as a safe directory
2024-02-08T13:48:49.7484780Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/pwcp/pwcp
2024-02-08T13:48:49.7515397Z Deleting the contents of '/home/runner/work/pwcp/pwcp'
2024-02-08T13:48:49.7520410Z ##[group]Initializing the repository
2024-02-08T13:48:49.7524507Z [command]/usr/bin/git init /home/runner/work/pwcp/pwcp
2024-02-08T13:48:49.7573099Z hint: Using 'master' as the name for the initial branch. This default branch name
2024-02-08T13:48:49.7575582Z hint: is subject to change. To configure the initial branch name to use in all
2024-02-08T13:48:49.7576835Z hint: of your new repositories, which will suppress this warning, call:
2024-02-08T13:48:49.7578032Z hint: 
2024-02-08T13:48:49.7579114Z hint: 	git config --global init.defaultBranch <name>
2024-02-08T13:48:49.7580635Z hint: 
2024-02-08T13:48:49.7581968Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
2024-02-08T13:48:49.7584041Z hint: 'development'. The just-created branch can be renamed via this command:
2024-02-08T13:48:49.7585414Z hint: 
2024-02-08T13:48:49.7586170Z hint: 	git branch -m <name>
2024-02-08T13:48:49.7587433Z Initialized empty Git repository in /home/runner/work/pwcp/pwcp/.git/
2024-02-08T13:48:49.7589313Z [command]/usr/bin/git remote add origin https://github.com/solaluset/pwcp
2024-02-08T13:48:49.7616549Z ##[endgroup]
2024-02-08T13:48:49.7617342Z ##[group]Disabling automatic garbage collection
2024-02-08T13:48:49.7620035Z [command]/usr/bin/git config --local gc.auto 0
2024-02-08T13:48:49.7641146Z ##[endgroup]
2024-02-08T13:48:49.7641919Z ##[group]Setting up auth
2024-02-08T13:48:49.7647731Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand
2024-02-08T13:48:49.7670147Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"
2024-02-08T13:48:49.7851525Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader
2024-02-08T13:48:49.7872629Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"
2024-02-08T13:48:49.8012406Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***
2024-02-08T13:48:49.8038391Z ##[endgroup]
2024-02-08T13:48:49.8039243Z ##[group]Fetching the repository
2024-02-08T13:48:49.8048099Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --progress --no-recurse-submodules --depth=1 origin +f25b579ba25a1863c39d8384c8bd330e0bf6278a:refs/remotes/origin/rename
2024-02-08T13:48:50.2196480Z remote: Enumerating objects: 33, done.        
2024-02-08T13:48:50.2210007Z remote: Counting objects:   3% (1/33)        
2024-02-08T13:48:50.2210907Z remote: Counting objects:   6% (2/33)        
2024-02-08T13:48:50.2211821Z remote: Counting objects:   9% (3/33)        
2024-02-08T13:48:50.2212840Z remote: Counting objects:  12% (4/33)        
2024-02-08T13:48:50.2213985Z remote: Counting objects:  15% (5/33)        
2024-02-08T13:48:50.2215067Z remote: Counting objects:  18% (6/33)        
2024-02-08T13:48:50.2216069Z remote: Counting objects:  21% (7/33)        
2024-02-08T13:48:50.2217087Z remote: Counting objects:  24% (8/33)        
2024-02-08T13:48:50.2218087Z remote: Counting objects:  27% (9/33)        
2024-02-08T13:48:50.2219054Z remote: Counting objects:  30% (10/33)        
2024-02-08T13:48:50.2220124Z remote: Counting objects:  33% (11/33)        
2024-02-08T13:48:50.2221187Z remote: Counting objects:  36% (12/33)        
2024-02-08T13:48:50.2222200Z remote: Counting objects:  39% (13/33)        
2024-02-08T13:48:50.2223322Z remote: Counting objects:  42% (14/33)        
2024-02-08T13:48:50.2224420Z remote: Counting objects:  45% (15/33)        
2024-02-08T13:48:50.2225168Z remote: Counting objects:  48% (16/33)        
2024-02-08T13:48:50.2226258Z remote: Counting objects:  51% (17/33)        
2024-02-08T13:48:50.2227336Z remote: Counting objects:  54% (18/33)        
2024-02-08T13:48:50.2228454Z remote: Counting objects:  57% (19/33)        
2024-02-08T13:48:50.2229622Z remote: Counting objects:  60% (20/33)        
2024-02-08T13:48:50.2230803Z remote: Counting objects:  63% (21/33)        
2024-02-08T13:48:50.2231869Z remote: Counting objects:  66% (22/33)        
2024-02-08T13:48:50.2233057Z remote: Counting objects:  69% (23/33)        
2024-02-08T13:48:50.2234205Z remote: Counting objects:  72% (24/33)        
2024-02-08T13:48:50.2235320Z remote: Counting objects:  75% (25/33)        
2024-02-08T13:48:50.2236502Z remote: Counting objects:  78% (26/33)        
2024-02-08T13:48:50.2237641Z remote: Counting objects:  81% (27/33)        
2024-02-08T13:48:50.2239044Z remote: Counting objects:  84% (28/33)        
2024-02-08T13:48:50.2240182Z remote: Counting objects:  87% (29/33)        
2024-02-08T13:48:50.2241310Z remote: Counting objects:  90% (30/33)        
2024-02-08T13:48:50.2242441Z remote: Counting objects:  93% (31/33)        
2024-02-08T13:48:50.2243919Z remote: Counting objects:  96% (32/33)        
2024-02-08T13:48:50.2245053Z remote: Counting objects: 100% (33/33)        
2024-02-08T13:48:50.2246197Z remote: Counting objects: 100% (33/33), done.        
2024-02-08T13:48:50.2247390Z remote: Compressing objects:   4% (1/24)        
2024-02-08T13:48:50.2248481Z remote: Compressing objects:   8% (2/24)        
2024-02-08T13:48:50.2249605Z remote: Compressing objects:  12% (3/24)        
2024-02-08T13:48:50.2250747Z remote: Compressing objects:  16% (4/24)        
2024-02-08T13:48:50.2251924Z remote: Compressing objects:  20% (5/24)        
2024-02-08T13:48:50.2253049Z remote: Compressing objects:  25% (6/24)        
2024-02-08T13:48:50.2254257Z remote: Compressing objects:  29% (7/24)        
2024-02-08T13:48:50.2255436Z remote: Compressing objects:  33% (8/24)        
2024-02-08T13:48:50.2256610Z remote: Compressing objects:  37% (9/24)        
2024-02-08T13:48:50.2257792Z remote: Compressing objects:  41% (10/24)        
2024-02-08T13:48:50.2259010Z remote: Compressing objects:  45% (11/24)        
2024-02-08T13:48:50.2260176Z remote: Compressing objects:  50% (12/24)        
2024-02-08T13:48:50.2261381Z remote: Compressing objects:  54% (13/24)        
2024-02-08T13:48:50.2262597Z remote: Compressing objects:  58% (14/24)        
2024-02-08T13:48:50.2263799Z remote: Compressing objects:  62% (15/24)        
2024-02-08T13:48:50.2265047Z remote: Compressing objects:  66% (16/24)        
2024-02-08T13:48:50.2266205Z remote: Compressing objects:  70% (17/24)        
2024-02-08T13:48:50.2267391Z remote: Compressing objects:  75% (18/24)        
2024-02-08T13:48:50.2268651Z remote: Compressing objects:  79% (19/24)        
2024-02-08T13:48:50.2270028Z remote: Compressing objects:  83% (20/24)        
2024-02-08T13:48:50.2271261Z remote: Compressing objects:  87% (21/24)        
2024-02-08T13:48:50.2272540Z remote: Compressing objects:  91% (22/24)        
2024-02-08T13:48:50.2273722Z remote: Compressing objects:  95% (23/24)        
2024-02-08T13:48:50.2274938Z remote: Compressing objects: 100% (24/24)        
2024-02-08T13:48:50.2276303Z remote: Compressing objects: 100% (24/24), done.        
2024-02-08T13:48:50.2278123Z remote: Total 33 (delta 0), reused 17 (delta 0), pack-reused 0        
2024-02-08T13:48:50.2304919Z From https://github.com/solaluset/pwcp
2024-02-08T13:48:50.2306092Z  * [new ref]         f25b579ba25a1863c39d8384c8bd330e0bf6278a -> origin/rename
2024-02-08T13:48:50.2321559Z ##[endgroup]
2024-02-08T13:48:50.2323090Z ##[group]Determining the checkout info
2024-02-08T13:48:50.2324654Z ##[endgroup]
2024-02-08T13:48:50.2325870Z ##[group]Checking out the ref
2024-02-08T13:48:50.2329997Z [command]/usr/bin/git checkout --progress --force -B rename refs/remotes/origin/rename
2024-02-08T13:48:50.2370920Z Switched to a new branch 'rename'
2024-02-08T13:48:50.2372449Z branch 'rename' set up to track 'origin/rename'.
2024-02-08T13:48:50.2382340Z ##[endgroup]
2024-02-08T13:48:50.2400038Z [command]/usr/bin/git log -1 --format='%H'
2024-02-08T13:48:50.2429758Z 'f25b579ba25a1863c39d8384c8bd330e0bf6278a'
2024-02-08T13:48:50.2740015Z ##[group]Run actions/setup-python@v2
2024-02-08T13:48:50.2740638Z with:
2024-02-08T13:48:50.2740967Z   python-version: 3.11
2024-02-08T13:48:50.2741649Z   token: ***
2024-02-08T13:48:50.2742013Z ##[endgroup]
2024-02-08T13:48:50.3910754Z Successfully setup CPython (3.11.7)
2024-02-08T13:48:50.4039809Z ##[group]Run pip install '.[tests]'
2024-02-08T13:48:50.4040615Z pip install '.[tests]'
2024-02-08T13:48:50.4097319Z shell: /usr/bin/bash -e {0}
2024-02-08T13:48:50.4097926Z env:
2024-02-08T13:48:50.4098417Z   pythonLocation: /opt/hostedtoolcache/Python/3.11.7/x64
2024-02-08T13:48:50.4099484Z   LD_LIBRARY_PATH: /opt/hostedtoolcache/Python/3.11.7/x64/lib
2024-02-08T13:48:50.4100606Z ##[endgroup]
2024-02-08T13:48:51.0147800Z Processing /home/runner/work/pwcp/pwcp
2024-02-08T13:48:51.0170202Z   Installing build dependencies: started
2024-02-08T13:48:52.4404455Z   Installing build dependencies: finished with status 'done'
2024-02-08T13:48:52.4433879Z   Getting requirements to build wheel: started
2024-02-08T13:48:52.7943883Z   Getting requirements to build wheel: finished with status 'done'
2024-02-08T13:48:52.7962811Z   Preparing metadata (pyproject.toml): started
2024-02-08T13:48:52.9936102Z   Preparing metadata (pyproject.toml): finished with status 'done'
2024-02-08T13:48:53.0000451Z Collecting pypp@ git+https://github.com/solaluset/pypp.git@7eca11e9073120959f131b11b3c800417a0049b6 (from pwcp==0.6.1b1)
2024-02-08T13:48:53.0005338Z   Cloning https://github.com/solaluset/pypp.git (to revision 7eca11e9073120959f131b11b3c800417a0049b6) to /tmp/pip-install-xqgx4sb1/pypp_400e35acaed54e7e82b7484833051097
2024-02-08T13:48:53.0023850Z   Running command git clone --filter=blob:none --quiet https://github.com/solaluset/pypp.git /tmp/pip-install-xqgx4sb1/pypp_400e35acaed54e7e82b7484833051097
2024-02-08T13:48:53.8838279Z   Running command git rev-parse -q --verify 'sha^7eca11e9073120959f131b11b3c800417a0049b6'
2024-02-08T13:48:53.8854672Z   Running command git fetch -q https://github.com/solaluset/pypp.git 7eca11e9073120959f131b11b3c800417a0049b6
2024-02-08T13:48:54.1900578Z   Running command git checkout -q 7eca11e9073120959f131b11b3c800417a0049b6
2024-02-08T13:48:54.5120462Z   Resolved https://github.com/solaluset/pypp.git to commit 7eca11e9073120959f131b11b3c800417a0049b6
2024-02-08T13:48:54.5122356Z   Running command git submodule update --init --recursive -q
2024-02-08T13:48:55.0824370Z   Installing build dependencies: started
2024-02-08T13:48:56.2063252Z   Installing build dependencies: finished with status 'done'
2024-02-08T13:48:56.2068189Z   Getting requirements to build wheel: started
2024-02-08T13:48:56.3649155Z   Getting requirements to build wheel: finished with status 'done'
2024-02-08T13:48:56.3663251Z   Installing backend dependencies: started
2024-02-08T13:48:56.9179868Z   Installing backend dependencies: finished with status 'done'
2024-02-08T13:48:56.9185133Z   Preparing metadata (pyproject.toml): started
2024-02-08T13:48:57.0537020Z   Preparing metadata (pyproject.toml): finished with status 'done'
2024-02-08T13:48:57.1260773Z Collecting pytest (from pwcp==0.6.1b1)
2024-02-08T13:48:57.1385190Z   Downloading pytest-8.0.0-py3-none-any.whl.metadata (7.8 kB)
2024-02-08T13:48:57.1614756Z Collecting iniconfig (from pytest->pwcp==0.6.1b1)
2024-02-08T13:48:57.1646286Z   Downloading iniconfig-2.0.0-py3-none-any.whl (5.9 kB)
2024-02-08T13:48:57.1883152Z Collecting packaging (from pytest->pwcp==0.6.1b1)
2024-02-08T13:48:57.1920566Z   Downloading packaging-23.2-py3-none-any.whl.metadata (3.2 kB)
2024-02-08T13:48:57.2112324Z Collecting pluggy<2.0,>=1.3.0 (from pytest->pwcp==0.6.1b1)
2024-02-08T13:48:57.2143098Z   Downloading pluggy-1.4.0-py3-none-any.whl.metadata (4.3 kB)
2024-02-08T13:48:57.2249246Z Downloading pytest-8.0.0-py3-none-any.whl (334 kB)
2024-02-08T13:48:57.2340118Z    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 334.0/334.0 kB 50.5 MB/s eta 0:00:00
2024-02-08T13:48:57.2375519Z Downloading pluggy-1.4.0-py3-none-any.whl (20 kB)
2024-02-08T13:48:57.2421854Z Downloading packaging-23.2-py3-none-any.whl (53 kB)
2024-02-08T13:48:57.2460295Z    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 53.0/53.0 kB 20.6 MB/s eta 0:00:00
2024-02-08T13:48:57.2496751Z Building wheels for collected packages: pwcp, pypp
2024-02-08T13:48:57.2504048Z   Building wheel for pwcp (pyproject.toml): started
2024-02-08T13:48:57.4611376Z   Building wheel for pwcp (pyproject.toml): finished with status 'done'
2024-02-08T13:48:57.4615612Z   Created wheel for pwcp: filename=pwcp-0.6.1b1-py3-none-any.whl size=6263 sha256=9503b39806ee52da4414519e748ae56c753c11530fad40875586c46b3ecc9375
2024-02-08T13:48:57.4617428Z   Stored in directory: /tmp/pip-ephem-wheel-cache-m99gh5rn/wheels/13/ae/63/097a409e78f9acacbf80589a2eee77e2c3de9bccaf63efd2cc
2024-02-08T13:48:57.4667481Z   Building wheel for pypp (pyproject.toml): started
2024-02-08T13:48:57.6353114Z   Building wheel for pypp (pyproject.toml): finished with status 'done'
2024-02-08T13:48:57.6358029Z   Created wheel for pypp: filename=pypp-1.32b0-py2.py3-none-any.whl size=91259 sha256=046fe99eb46328079c7313bbc1abe3202f839780532964ca404db03e74645d43
2024-02-08T13:48:57.6359546Z   Stored in directory: /home/runner/.cache/pip/wheels/e8/1a/20/cf78cbc9433a00fff60c4a2002c895b140db1f787f80f7eeab
2024-02-08T13:48:57.6381942Z Successfully built pwcp pypp
2024-02-08T13:48:57.6818451Z Installing collected packages: pypp, pwcp, pluggy, packaging, iniconfig, pytest
2024-02-08T13:48:57.9876221Z Successfully installed iniconfig-2.0.0 packaging-23.2 pluggy-1.4.0 pwcp-0.6.1b1 pypp-1.32b0 pytest-8.0.0
2024-02-08T13:48:58.0305485Z 
2024-02-08T13:48:58.0306698Z [notice] A new release of pip is available: 23.2.1 -> 24.0
2024-02-08T13:48:58.0309768Z [notice] To update, run: pip install --upgrade pip
2024-02-08T13:48:58.1095206Z ##[group]Run pwcp --version && pytest
2024-02-08T13:48:58.1095708Z pwcp --version && pytest
2024-02-08T13:48:58.1134371Z shell: /usr/bin/bash -e {0}
2024-02-08T13:48:58.1134720Z env:
2024-02-08T13:48:58.1135083Z   pythonLocation: /opt/hostedtoolcache/Python/3.11.7/x64
2024-02-08T13:48:58.1135643Z   LD_LIBRARY_PATH: /opt/hostedtoolcache/Python/3.11.7/x64/lib
2024-02-08T13:48:58.1136095Z ##[endgroup]
2024-02-08T13:48:58.1589266Z pwcp 0.6.1b1
2024-02-08T13:48:58.4125512Z ============================= test session starts ==============================
2024-02-08T13:48:58.4126770Z platform linux -- Python 3.11.7, pytest-8.0.0, pluggy-1.4.0
2024-02-08T13:48:58.4127395Z rootdir: /home/runner/work/pwcp/pwcp
2024-02-08T13:48:58.4127835Z collected 11 items
2024-02-08T13:48:58.4128014Z 
2024-02-08T13:48:58.6759859Z tests/test_pwcp.py ........
2024-02-08T13:48:58.6760622Z INTERNALERROR> Traceback (most recent call last):
2024-02-08T13:48:58.6762855Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/main.py", line 272, in wrap_session
2024-02-08T13:48:58.6764882Z INTERNALERROR>     session.exitstatus = doit(config, session) or 0
2024-02-08T13:48:58.6765923Z INTERNALERROR>                          ^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6767704Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/main.py", line 326, in _main
2024-02-08T13:48:58.6769390Z INTERNALERROR>     config.hook.pytest_runtestloop(session=session)
2024-02-08T13:48:58.6771210Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_hooks.py", line 501, in __call__
2024-02-08T13:48:58.6772983Z INTERNALERROR>     return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult)
2024-02-08T13:48:58.6774824Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6776865Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_manager.py", line 119, in _hookexec
2024-02-08T13:48:58.6778844Z INTERNALERROR>     return self._inner_hookexec(hook_name, methods, kwargs, firstresult)
2024-02-08T13:48:58.6780011Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6781916Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 138, in _multicall
2024-02-08T13:48:58.6783798Z INTERNALERROR>     raise exception.with_traceback(exception.__traceback__)
2024-02-08T13:48:58.6785829Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 121, in _multicall
2024-02-08T13:48:58.6787762Z INTERNALERROR>     teardown.throw(exception)  # type: ignore[union-attr]
2024-02-08T13:48:58.6788837Z INTERNALERROR>     ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6790649Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/logging.py", line 796, in pytest_runtestloop
2024-02-08T13:48:58.6792614Z INTERNALERROR>     return (yield)  # Run all the tests.
2024-02-08T13:48:58.6793543Z INTERNALERROR>             ^^^^^
2024-02-08T13:48:58.6795302Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 102, in _multicall
2024-02-08T13:48:58.6798896Z INTERNALERROR>     res = hook_impl.function(*args)
2024-02-08T13:48:58.6799747Z INTERNALERROR>           ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6801510Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/main.py", line 351, in pytest_runtestloop
2024-02-08T13:48:58.6803485Z INTERNALERROR>     item.config.hook.pytest_runtest_protocol(item=item, nextitem=nextitem)
2024-02-08T13:48:58.6805384Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_hooks.py", line 501, in __call__
2024-02-08T13:48:58.6807389Z INTERNALERROR>     return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult)
2024-02-08T13:48:58.6808657Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6810380Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_manager.py", line 119, in _hookexec
2024-02-08T13:48:58.6812095Z INTERNALERROR>     return self._inner_hookexec(hook_name, methods, kwargs, firstresult)
2024-02-08T13:48:58.6813248Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6814987Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 138, in _multicall
2024-02-08T13:48:58.6816580Z INTERNALERROR>     raise exception.with_traceback(exception.__traceback__)
2024-02-08T13:48:58.6818428Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 121, in _multicall
2024-02-08T13:48:58.6820173Z INTERNALERROR>     teardown.throw(exception)  # type: ignore[union-attr]
2024-02-08T13:48:58.6821046Z INTERNALERROR>     ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6822782Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/warnings.py", line 109, in pytest_runtest_protocol
2024-02-08T13:48:58.6824294Z INTERNALERROR>     return (yield)
2024-02-08T13:48:58.6824891Z INTERNALERROR>             ^^^^^
2024-02-08T13:48:58.6826397Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 121, in _multicall
2024-02-08T13:48:58.6828128Z INTERNALERROR>     teardown.throw(exception)  # type: ignore[union-attr]
2024-02-08T13:48:58.6829022Z INTERNALERROR>     ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6830823Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/assertion/__init__.py", line 174, in pytest_runtest_protocol
2024-02-08T13:48:58.6832405Z INTERNALERROR>     return (yield)
2024-02-08T13:48:58.6833009Z INTERNALERROR>             ^^^^^
2024-02-08T13:48:58.6834521Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 121, in _multicall
2024-02-08T13:48:58.6836243Z INTERNALERROR>     teardown.throw(exception)  # type: ignore[union-attr]
2024-02-08T13:48:58.6837147Z INTERNALERROR>     ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6838888Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/unittest.py", line 408, in pytest_runtest_protocol
2024-02-08T13:48:58.6840347Z INTERNALERROR>     res = yield
2024-02-08T13:48:58.6840913Z INTERNALERROR>           ^^^^^
2024-02-08T13:48:58.6842447Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 121, in _multicall
2024-02-08T13:48:58.6844494Z INTERNALERROR>     teardown.throw(exception)  # type: ignore[union-attr]
2024-02-08T13:48:58.6845413Z INTERNALERROR>     ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6847202Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/faulthandler.py", line 85, in pytest_runtest_protocol
2024-02-08T13:48:58.6848736Z INTERNALERROR>     return (yield)
2024-02-08T13:48:58.6849308Z INTERNALERROR>             ^^^^^
2024-02-08T13:48:58.6850843Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 102, in _multicall
2024-02-08T13:48:58.6852383Z INTERNALERROR>     res = hook_impl.function(*args)
2024-02-08T13:48:58.6853137Z INTERNALERROR>           ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6854895Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/runner.py", line 114, in pytest_runtest_protocol
2024-02-08T13:48:58.6856479Z INTERNALERROR>     runtestprotocol(item, nextitem=nextitem)
2024-02-08T13:48:58.6858528Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/runner.py", line 133, in runtestprotocol
2024-02-08T13:48:58.6860262Z INTERNALERROR>     reports.append(call_and_report(item, "call", log))
2024-02-08T13:48:58.6861275Z INTERNALERROR>                    ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6863102Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/runner.py", line 228, in call_and_report
2024-02-08T13:48:58.6864855Z INTERNALERROR>     report: TestReport = hook.pytest_runtest_makereport(item=item, call=call)
2024-02-08T13:48:58.6866041Z INTERNALERROR>                          ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6867767Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_hooks.py", line 501, in __call__
2024-02-08T13:48:58.6869508Z INTERNALERROR>     return self._hookexec(self.name, self._hookimpls.copy(), kwargs, firstresult)
2024-02-08T13:48:58.6870724Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6872496Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_manager.py", line 119, in _hookexec
2024-02-08T13:48:58.6874202Z INTERNALERROR>     return self._inner_hookexec(hook_name, methods, kwargs, firstresult)
2024-02-08T13:48:58.6875292Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6877044Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 138, in _multicall
2024-02-08T13:48:58.6878679Z INTERNALERROR>     raise exception.with_traceback(exception.__traceback__)
2024-02-08T13:48:58.6880476Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 121, in _multicall
2024-02-08T13:48:58.6882206Z INTERNALERROR>     teardown.throw(exception)  # type: ignore[union-attr]
2024-02-08T13:48:58.6883349Z INTERNALERROR>     ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6885224Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/tmpdir.py", line 316, in pytest_runtest_makereport
2024-02-08T13:48:58.6886748Z INTERNALERROR>     rep = yield
2024-02-08T13:48:58.6887317Z INTERNALERROR>           ^^^^^
2024-02-08T13:48:58.6888811Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 121, in _multicall
2024-02-08T13:48:58.6890531Z INTERNALERROR>     teardown.throw(exception)  # type: ignore[union-attr]
2024-02-08T13:48:58.6891430Z INTERNALERROR>     ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6893162Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/skipping.py", line 269, in pytest_runtest_makereport
2024-02-08T13:48:58.6894902Z INTERNALERROR>     rep = yield
2024-02-08T13:48:58.6895441Z INTERNALERROR>           ^^^^^
2024-02-08T13:48:58.6896954Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/pluggy/_callers.py", line 102, in _multicall
2024-02-08T13:48:58.6898441Z INTERNALERROR>     res = hook_impl.function(*args)
2024-02-08T13:48:58.6899186Z INTERNALERROR>           ^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6900984Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/runner.py", line 372, in pytest_runtest_makereport
2024-02-08T13:48:58.6902696Z INTERNALERROR>     return TestReport.from_item_and_call(item, call)
2024-02-08T13:48:58.6903668Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6905394Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/reports.py", line 364, in from_item_and_call
2024-02-08T13:48:58.6906976Z INTERNALERROR>     longrepr = item.repr_failure(excinfo)
2024-02-08T13:48:58.6907965Z INTERNALERROR>                ^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6909664Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/python.py", line 1877, in repr_failure
2024-02-08T13:48:58.6911242Z INTERNALERROR>     return self._repr_failure_py(excinfo, style=style)
2024-02-08T13:48:58.6912231Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6913974Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/nodes.py", line 497, in _repr_failure_py
2024-02-08T13:48:58.6915398Z INTERNALERROR>     return excinfo.getrepr(
2024-02-08T13:48:58.6916089Z INTERNALERROR>            ^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6917675Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/_code/code.py", line 698, in getrepr
2024-02-08T13:48:58.6919141Z INTERNALERROR>     return fmt.repr_excinfo(self)
2024-02-08T13:48:58.6919789Z INTERNALERROR>            ^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6920784Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/_code/code.py", line 1057, in repr_excinfo
2024-02-08T13:48:58.6921710Z INTERNALERROR>     reprtraceback = self.repr_traceback(excinfo_)
2024-02-08T13:48:58.6922240Z INTERNALERROR>                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6923460Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/_code/code.py", line 981, in repr_traceback
2024-02-08T13:48:58.6924306Z INTERNALERROR>     entries = [
2024-02-08T13:48:58.6924639Z INTERNALERROR>               ^
2024-02-08T13:48:58.6925567Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/_code/code.py", line 982, in <listcomp>
2024-02-08T13:48:58.6926563Z INTERNALERROR>     self.repr_traceback_entry(entry, excinfo if last == entry else None)
2024-02-08T13:48:58.6927734Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/_code/code.py", line 920, in repr_traceback_entry
2024-02-08T13:48:58.6928646Z INTERNALERROR>     source = self._getentrysource(entry)
2024-02-08T13:48:58.6929140Z INTERNALERROR>              ^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6930484Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/_code/code.py", line 822, in _getentrysource
2024-02-08T13:48:58.6931921Z INTERNALERROR>     source = entry.getsource(self.astcache)
2024-02-08T13:48:58.6932803Z INTERNALERROR>              ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6934560Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/_code/code.py", line 259, in getsource
2024-02-08T13:48:58.6935963Z INTERNALERROR>     astnode, _, end = getstatementrange_ast(
2024-02-08T13:48:58.6936853Z INTERNALERROR>                       ^^^^^^^^^^^^^^^^^^^^^^
2024-02-08T13:48:58.6938953Z INTERNALERROR>   File "/opt/hostedtoolcache/Python/3.11.7/x64/lib/python3.11/site-packages/_pytest/_code/source.py", line 199, in getstatementrange_ast
2024-02-08T13:48:58.6939972Z INTERNALERROR>     block_finder.started = source.lines[start][0].isspace()
2024-02-08T13:48:58.6940573Z INTERNALERROR>                            ~~~~~~~~~~~~~~~~~~~^^^
2024-02-08T13:48:58.6941127Z INTERNALERROR> IndexError: string index out of range
2024-02-08T13:48:58.6941437Z 
2024-02-08T13:48:58.6941623Z ============================== 8 passed in 0.33s ===============================
2024-02-08T13:48:58.7091412Z ##[error]Process completed with exit code 3.
2024-02-08T13:48:58.7171682Z Post job cleanup.
2024-02-08T13:48:58.8102094Z [command]/usr/bin/git version
2024-02-08T13:48:58.8138776Z git version 2.43.0
2024-02-08T13:48:58.8179560Z Temporarily overriding HOME='/home/runner/work/_temp/d52a16b2-2e64-43cf-8dd1-81814e5f6704' before making global git config changes
2024-02-08T13:48:58.8180943Z Adding repository directory to the temporary git global config as a safe directory
2024-02-08T13:48:58.8184847Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/pwcp/pwcp
2024-02-08T13:48:58.8211341Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand
2024-02-08T13:48:58.8235169Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"
2024-02-08T13:48:58.8375393Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader
2024-02-08T13:48:58.8391318Z http.https://github.com/.extraheader
2024-02-08T13:48:58.8399720Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader
2024-02-08T13:48:58.8422441Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"
2024-02-08T13:48:58.8750323Z Cleaning up orphan processes