2022-09-29T10:15:59.8159821Z Requested labels: windows-latest 2022-09-29T10:15:59.8159864Z Job defined at: QCoDeS/Qcodes/.github/workflows/pytest.yaml@refs/pull/4661/merge 2022-09-29T10:15:59.8159886Z Waiting for a runner to pick up this job... 2022-09-29T10:21:31.5042339Z Job is waiting for a hosted runner to come online. 2022-09-29T10:21:43.3354158Z Job is about to start running on the hosted runner: GitHub Actions 10 (hosted) 2022-09-29T10:21:48.7364340Z Current runner version: '2.297.0' 2022-09-29T10:21:48.7390596Z ##[group]Operating System 2022-09-29T10:21:48.7391114Z Microsoft Windows Server 2022 2022-09-29T10:21:48.7391377Z 10.0.20348 2022-09-29T10:21:48.7391681Z Datacenter 2022-09-29T10:21:48.7391957Z ##[endgroup] 2022-09-29T10:21:48.7392203Z ##[group]Runner Image 2022-09-29T10:21:48.7392526Z Image: windows-2022 2022-09-29T10:21:48.7392815Z Version: 20220925.1 2022-09-29T10:21:48.7393313Z Included Software: https://github.com/actions/runner-images/blob/win22/20220925.1/images/win/Windows2022-Readme.md 2022-09-29T10:21:48.7393862Z Image Release: https://github.com/actions/runner-images/releases/tag/win22%2F20220925.1 2022-09-29T10:21:48.7394272Z ##[endgroup] 2022-09-29T10:21:48.7394580Z ##[group]Runner Image Provisioner 2022-09-29T10:21:48.7394865Z 1.0.0.0-main-20220916-1 2022-09-29T10:21:48.7395178Z ##[endgroup] 2022-09-29T10:21:48.7396097Z ##[group]GITHUB_TOKEN Permissions 2022-09-29T10:21:48.7396780Z Actions: write 2022-09-29T10:21:48.7397073Z Checks: write 2022-09-29T10:21:48.7397381Z Contents: write 2022-09-29T10:21:48.7397682Z Deployments: write 2022-09-29T10:21:48.7397939Z Discussions: write 2022-09-29T10:21:48.7398223Z Issues: write 2022-09-29T10:21:48.7398519Z Metadata: read 2022-09-29T10:21:48.7398759Z Packages: write 2022-09-29T10:21:48.7399055Z Pages: write 2022-09-29T10:21:48.7399342Z PullRequests: write 2022-09-29T10:21:48.7399631Z RepositoryProjects: write 2022-09-29T10:21:48.7399955Z SecurityEvents: write 2022-09-29T10:21:48.7400284Z Statuses: write 2022-09-29T10:21:48.7400524Z ##[endgroup] 2022-09-29T10:21:48.7404027Z Secret source: Actions 2022-09-29T10:21:48.7404618Z Prepare workflow directory 2022-09-29T10:21:48.8456968Z Prepare all required actions 2022-09-29T10:21:48.8645489Z Getting action download info 2022-09-29T10:21:49.0630497Z Download action repository 'actions/checkout@v3.0.2' (SHA:2541b1294d2704b0964813337f33b291d3f8596b) 2022-09-29T10:21:49.4447036Z Download action repository 'actions/setup-python@v4.2.0' (SHA:b55428b1882923874294fa556849718a1d7f2ca5) 2022-09-29T10:21:49.7501606Z Download action repository 'codecov/codecov-action@v3.1.1' (SHA:d9f34f8cd5cb3b3eb79b3e4b5dae3a16df499a70) 2022-09-29T10:21:50.3656531Z ##[group]Run actions/checkout@v3.0.2 2022-09-29T10:21:50.3656939Z with: 2022-09-29T10:21:50.3657129Z submodules: true 2022-09-29T10:21:50.3657357Z repository: QCoDeS/Qcodes 2022-09-29T10:21:50.3657831Z token: *** 2022-09-29T10:21:50.3658040Z ssh-strict: true 2022-09-29T10:21:50.3658261Z persist-credentials: true 2022-09-29T10:21:50.3658483Z clean: true 2022-09-29T10:21:50.3658680Z fetch-depth: 1 2022-09-29T10:21:50.3658867Z lfs: false 2022-09-29T10:21:50.3659091Z set-safe-directory: true 2022-09-29T10:21:50.3659317Z env: 2022-09-29T10:21:50.3659493Z DISPLAY: :99.0 2022-09-29T10:21:50.3659695Z OS: windows-latest 2022-09-29T10:21:50.3659910Z PYTHON: 3.10 2022-09-29T10:21:50.3660091Z ##[endgroup] 2022-09-29T10:22:02.0818982Z Syncing repository: QCoDeS/Qcodes 2022-09-29T10:22:02.1669852Z ##[group]Getting Git version info 2022-09-29T10:22:02.1670910Z Working directory is 'D:\a\Qcodes\Qcodes' 2022-09-29T10:22:02.2066823Z [command]"C:\Program Files\Git\bin\git.exe" version 2022-09-29T10:22:02.8401500Z git version 2.37.3.windows.1 2022-09-29T10:22:02.8446821Z ##[endgroup] 2022-09-29T10:22:02.8483070Z Temporarily overriding HOME='D:\a\_temp\424231d0-db42-4707-a4eb-1a9758df8739' before making global git config changes 2022-09-29T10:22:02.8484814Z Adding repository directory to the temporary git global config as a safe directory 2022-09-29T10:22:02.8494282Z [command]"C:\Program Files\Git\bin\git.exe" config --global --add safe.directory D:\a\Qcodes\Qcodes 2022-09-29T10:22:02.9201482Z Deleting the contents of 'D:\a\Qcodes\Qcodes' 2022-09-29T10:22:02.9229520Z ##[group]Initializing the repository 2022-09-29T10:22:02.9260369Z [command]"C:\Program Files\Git\bin\git.exe" init D:\a\Qcodes\Qcodes 2022-09-29T10:22:03.0302394Z Initialized empty Git repository in D:/a/Qcodes/Qcodes/.git/ 2022-09-29T10:22:03.0345004Z [command]"C:\Program Files\Git\bin\git.exe" remote add origin https://github.com/QCoDeS/Qcodes 2022-09-29T10:22:03.0922589Z ##[endgroup] 2022-09-29T10:22:03.0923116Z ##[group]Disabling automatic garbage collection 2022-09-29T10:22:03.0931828Z [command]"C:\Program Files\Git\bin\git.exe" config --local gc.auto 0 2022-09-29T10:22:03.1155132Z ##[endgroup] 2022-09-29T10:22:03.1155769Z ##[group]Setting up auth 2022-09-29T10:22:03.1167968Z [command]"C:\Program Files\Git\bin\git.exe" config --local --name-only --get-regexp core\.sshCommand 2022-09-29T10:22:03.1384790Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach --recursive "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :" 2022-09-29T10:22:05.7180574Z [command]"C:\Program Files\Git\bin\git.exe" config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader 2022-09-29T10:22:05.7460947Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach --recursive "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :" 2022-09-29T10:22:06.4443467Z [command]"C:\Program Files\Git\bin\git.exe" config --local http.https://github.com/.extraheader "AUTHORIZATION: basic ***" 2022-09-29T10:22:06.4672691Z ##[endgroup] 2022-09-29T10:22:06.4677231Z ##[group]Fetching the repository 2022-09-29T10:22:06.4685501Z [command]"C:\Program Files\Git\bin\git.exe" -c protocol.version=2 fetch --no-tags --prune --progress --no-recurse-submodules --depth=1 origin +26637f5615787b0af257bd88500545a92c7ac07e:refs/remotes/pull/4661/merge 2022-09-29T10:22:08.4508755Z remote: Enumerating objects: 1097, done. 2022-09-29T10:22:08.4509420Z remote: Counting objects: 0% (1/1097) 2022-09-29T10:22:08.4510746Z remote: Counting objects: 1% (11/1097) 2022-09-29T10:22:08.4511175Z remote: Counting objects: 2% (22/1097) 2022-09-29T10:22:08.4511655Z remote: Counting objects: 3% (33/1097) 2022-09-29T10:22:08.4512053Z remote: Counting objects: 4% (44/1097) 2022-09-29T10:22:08.4514331Z remote: Counting objects: 5% (55/1097) 2022-09-29T10:22:08.4514947Z remote: Counting objects: 6% (66/1097) 2022-09-29T10:22:08.4515255Z remote: Counting objects: 7% (77/1097) 2022-09-29T10:22:08.4518308Z remote: Counting objects: 8% (88/1097) 2022-09-29T10:22:08.4518658Z remote: Counting objects: 9% (99/1097) 2022-09-29T10:22:08.4519122Z remote: Counting objects: 10% (110/1097) 2022-09-29T10:22:08.4519427Z remote: Counting objects: 11% (121/1097) 2022-09-29T10:22:08.4519720Z remote: Counting objects: 12% (132/1097) 2022-09-29T10:22:08.4520018Z remote: Counting objects: 13% (143/1097) 2022-09-29T10:22:08.4520309Z remote: Counting objects: 14% (154/1097) 2022-09-29T10:22:08.4520601Z remote: Counting objects: 15% (165/1097) 2022-09-29T10:22:08.4520892Z remote: Counting objects: 16% (176/1097) 2022-09-29T10:22:08.4521187Z remote: Counting objects: 17% (187/1097) 2022-09-29T10:22:08.4521472Z remote: Counting objects: 18% (198/1097) 2022-09-29T10:22:08.4521754Z remote: Counting objects: 19% (209/1097) 2022-09-29T10:22:08.4522026Z remote: Counting objects: 20% (220/1097) 2022-09-29T10:22:08.4522309Z remote: Counting objects: 21% (231/1097) 2022-09-29T10:22:08.4522590Z remote: Counting objects: 22% (242/1097) 2022-09-29T10:22:08.4522859Z remote: Counting objects: 23% (253/1097) 2022-09-29T10:22:08.4523140Z remote: Counting objects: 24% (264/1097) 2022-09-29T10:22:08.4523424Z remote: Counting objects: 25% (275/1097) 2022-09-29T10:22:08.4523691Z remote: Counting objects: 26% (286/1097) 2022-09-29T10:22:08.4523969Z remote: Counting objects: 27% (297/1097) 2022-09-29T10:22:08.4524999Z remote: Counting objects: 28% (308/1097) 2022-09-29T10:22:08.4525281Z remote: Counting objects: 29% (319/1097) 2022-09-29T10:22:08.4525562Z remote: Counting objects: 30% (330/1097) 2022-09-29T10:22:08.4525848Z remote: Counting objects: 31% (341/1097) 2022-09-29T10:22:08.4526152Z remote: Counting objects: 32% (352/1097) 2022-09-29T10:22:08.4526424Z remote: Counting objects: 33% (363/1097) 2022-09-29T10:22:08.4526716Z remote: Counting objects: 34% (373/1097) 2022-09-29T10:22:08.4527003Z remote: Counting objects: 35% (384/1097) 2022-09-29T10:22:08.4527287Z remote: Counting objects: 36% (395/1097) 2022-09-29T10:22:08.4527555Z remote: Counting objects: 37% (406/1097) 2022-09-29T10:22:08.4527842Z remote: Counting objects: 38% (417/1097) 2022-09-29T10:22:08.4528126Z remote: Counting objects: 39% (428/1097) 2022-09-29T10:22:08.4528397Z remote: Counting objects: 40% (439/1097) 2022-09-29T10:22:08.4528682Z remote: Counting objects: 41% (450/1097) 2022-09-29T10:22:08.4528963Z remote: Counting objects: 42% (461/1097) 2022-09-29T10:22:08.4529237Z remote: Counting objects: 43% (472/1097) 2022-09-29T10:22:08.4529527Z remote: Counting objects: 44% (483/1097) 2022-09-29T10:22:08.4529811Z remote: Counting objects: 45% (494/1097) 2022-09-29T10:22:08.4530079Z remote: Counting objects: 46% (505/1097) 2022-09-29T10:22:08.4530361Z remote: Counting objects: 47% (516/1097) 2022-09-29T10:22:08.4530641Z remote: Counting objects: 48% (527/1097) 2022-09-29T10:22:08.4530923Z remote: Counting objects: 49% (538/1097) 2022-09-29T10:22:08.4531191Z remote: Counting objects: 50% (549/1097) 2022-09-29T10:22:08.4531470Z remote: Counting objects: 51% (560/1097) 2022-09-29T10:22:08.4531748Z remote: Counting objects: 52% (571/1097) 2022-09-29T10:22:08.4532028Z remote: Counting objects: 53% (582/1097) 2022-09-29T10:22:08.4532311Z remote: Counting objects: 54% (593/1097) 2022-09-29T10:22:08.4532592Z remote: Counting objects: 55% (604/1097) 2022-09-29T10:22:08.4533229Z remote: Counting objects: 56% (615/1097) 2022-09-29T10:22:08.4533529Z remote: Counting objects: 57% (626/1097) 2022-09-29T10:22:08.4533811Z remote: Counting objects: 58% (637/1097) 2022-09-29T10:22:08.4534099Z remote: Counting objects: 59% (648/1097) 2022-09-29T10:22:08.4534368Z remote: Counting objects: 60% (659/1097) 2022-09-29T10:22:08.4534649Z remote: Counting objects: 61% (670/1097) 2022-09-29T10:22:08.4534933Z remote: Counting objects: 62% (681/1097) 2022-09-29T10:22:08.4535202Z remote: Counting objects: 63% (692/1097) 2022-09-29T10:22:08.4535482Z remote: Counting objects: 64% (703/1097) 2022-09-29T10:22:08.4535762Z remote: Counting objects: 65% (714/1097) 2022-09-29T10:22:08.4536029Z remote: Counting objects: 66% (725/1097) 2022-09-29T10:22:08.4536317Z remote: Counting objects: 67% (735/1097) 2022-09-29T10:22:08.4536595Z remote: Counting objects: 68% (746/1097) 2022-09-29T10:22:08.4536867Z remote: Counting objects: 69% (757/1097) 2022-09-29T10:22:08.4537152Z remote: Counting objects: 70% (768/1097) 2022-09-29T10:22:08.4537430Z remote: Counting objects: 71% (779/1097) 2022-09-29T10:22:08.4537711Z remote: Counting objects: 72% (790/1097) 2022-09-29T10:22:08.4537982Z remote: Counting objects: 73% (801/1097) 2022-09-29T10:22:08.4538262Z remote: Counting objects: 74% (812/1097) 2022-09-29T10:22:08.4538542Z remote: Counting objects: 75% (823/1097) 2022-09-29T10:22:08.4538810Z remote: Counting objects: 76% (834/1097) 2022-09-29T10:22:08.4539092Z remote: Counting objects: 77% (845/1097) 2022-09-29T10:22:08.4539379Z remote: Counting objects: 78% (856/1097) 2022-09-29T10:22:08.4539651Z remote: Counting objects: 79% (867/1097) 2022-09-29T10:22:08.4540004Z remote: Counting objects: 80% (878/1097) 2022-09-29T10:22:08.4540309Z remote: Counting objects: 81% (889/1097) 2022-09-29T10:22:08.4540594Z remote: Counting objects: 82% (900/1097) 2022-09-29T10:22:08.4540864Z remote: Counting objects: 83% (911/1097) 2022-09-29T10:22:08.4541148Z remote: Counting objects: 84% (922/1097) 2022-09-29T10:22:08.4541431Z remote: Counting objects: 85% (933/1097) 2022-09-29T10:22:08.4542027Z remote: Counting objects: 86% (944/1097) 2022-09-29T10:22:08.4542310Z remote: Counting objects: 87% (955/1097) 2022-09-29T10:22:08.4542589Z remote: Counting objects: 88% (966/1097) 2022-09-29T10:22:08.4542862Z remote: Counting objects: 89% (977/1097) 2022-09-29T10:22:08.4543551Z remote: Counting objects: 90% (988/1097) 2022-09-29T10:22:08.4543852Z remote: Counting objects: 91% (999/1097) 2022-09-29T10:22:08.4544150Z remote: Counting objects: 92% (1010/1097) 2022-09-29T10:22:08.4544437Z remote: Counting objects: 93% (1021/1097) 2022-09-29T10:22:08.4544926Z remote: Counting objects: 94% (1032/1097) 2022-09-29T10:22:08.4545225Z remote: Counting objects: 95% (1043/1097) 2022-09-29T10:22:08.4545530Z remote: Counting objects: 96% (1054/1097) 2022-09-29T10:22:08.4545821Z remote: Counting objects: 97% (1065/1097) 2022-09-29T10:22:08.4546115Z remote: Counting objects: 98% (1076/1097) 2022-09-29T10:22:08.4546410Z remote: Counting objects: 99% (1087/1097) 2022-09-29T10:22:08.4546690Z remote: Counting objects: 100% (1097/1097) 2022-09-29T10:22:08.4546996Z remote: Counting objects: 100% (1097/1097), done. 2022-09-29T10:22:08.4547321Z remote: Compressing objects: 0% (1/999) 2022-09-29T10:22:08.4547631Z remote: Compressing objects: 1% (10/999) 2022-09-29T10:22:08.4547925Z remote: Compressing objects: 2% (20/999) 2022-09-29T10:22:08.4548232Z remote: Compressing objects: 3% (30/999) 2022-09-29T10:22:08.4548539Z remote: Compressing objects: 4% (40/999) 2022-09-29T10:22:08.4548948Z remote: Compressing objects: 5% (50/999) 2022-09-29T10:22:08.4549271Z remote: Compressing objects: 6% (60/999) 2022-09-29T10:22:08.4575382Z remote: Compressing objects: 7% (70/999) 2022-09-29T10:22:08.4639855Z remote: Compressing objects: 8% (80/999) 2022-09-29T10:22:08.4645657Z remote: Compressing objects: 9% (90/999) 2022-09-29T10:22:08.4674719Z remote: Compressing objects: 10% (100/999) 2022-09-29T10:22:08.4691678Z remote: Compressing objects: 11% (110/999) 2022-09-29T10:22:08.4741598Z remote: Compressing objects: 12% (120/999) 2022-09-29T10:22:08.4769963Z remote: Compressing objects: 13% (130/999) 2022-09-29T10:22:08.4806792Z remote: Compressing objects: 14% (140/999) 2022-09-29T10:22:08.4866871Z remote: Compressing objects: 15% (150/999) 2022-09-29T10:22:08.4907940Z remote: Compressing objects: 16% (160/999) 2022-09-29T10:22:08.4948975Z remote: Compressing objects: 17% (170/999) 2022-09-29T10:22:08.5001236Z remote: Compressing objects: 18% (180/999) 2022-09-29T10:22:08.5038076Z remote: Compressing objects: 19% (190/999) 2022-09-29T10:22:08.5106373Z remote: Compressing objects: 20% (200/999) 2022-09-29T10:22:08.5184018Z remote: Compressing objects: 21% (210/999) 2022-09-29T10:22:08.5218236Z remote: Compressing objects: 22% (220/999) 2022-09-29T10:22:08.5239827Z remote: Compressing objects: 23% (230/999) 2022-09-29T10:22:08.5268594Z remote: Compressing objects: 24% (240/999) 2022-09-29T10:22:08.5336139Z remote: Compressing objects: 25% (250/999) 2022-09-29T10:22:08.5347318Z remote: Compressing objects: 26% (260/999) 2022-09-29T10:22:08.5380571Z remote: Compressing objects: 27% (270/999) 2022-09-29T10:22:08.5443307Z remote: Compressing objects: 28% (280/999) 2022-09-29T10:22:08.5529316Z remote: Compressing objects: 29% (290/999) 2022-09-29T10:22:08.5571672Z remote: Compressing objects: 30% (300/999) 2022-09-29T10:22:08.5594164Z remote: Compressing objects: 31% (310/999) 2022-09-29T10:22:08.5654941Z remote: Compressing objects: 32% (320/999) 2022-09-29T10:22:08.5699806Z remote: Compressing objects: 33% (330/999) 2022-09-29T10:22:08.5743276Z remote: Compressing objects: 34% (340/999) 2022-09-29T10:22:08.5743568Z remote: Compressing objects: 35% (350/999) 2022-09-29T10:22:08.5743849Z remote: Compressing objects: 36% (360/999) 2022-09-29T10:22:08.5744125Z remote: Compressing objects: 37% (370/999) 2022-09-29T10:22:08.5744385Z remote: Compressing objects: 38% (380/999) 2022-09-29T10:22:08.5759020Z remote: Compressing objects: 39% (390/999) 2022-09-29T10:22:08.5779957Z remote: Compressing objects: 40% (400/999) 2022-09-29T10:22:08.5818267Z remote: Compressing objects: 41% (410/999) 2022-09-29T10:22:08.5845316Z remote: Compressing objects: 42% (420/999) 2022-09-29T10:22:08.5846023Z remote: Compressing objects: 43% (430/999) 2022-09-29T10:22:08.5846616Z remote: Compressing objects: 44% (440/999) 2022-09-29T10:22:08.5846956Z remote: Compressing objects: 45% (450/999) 2022-09-29T10:22:08.5855426Z remote: Compressing objects: 46% (460/999) 2022-09-29T10:22:08.5858203Z remote: Compressing objects: 47% (470/999) 2022-09-29T10:22:08.5895435Z remote: Compressing objects: 48% (480/999) 2022-09-29T10:22:08.5900017Z remote: Compressing objects: 49% (490/999) 2022-09-29T10:22:08.5907740Z remote: Compressing objects: 50% (500/999) 2022-09-29T10:22:08.5932790Z remote: Compressing objects: 51% (510/999) 2022-09-29T10:22:08.5933096Z remote: Compressing objects: 52% (520/999) 2022-09-29T10:22:08.5943385Z remote: Compressing objects: 53% (530/999) 2022-09-29T10:22:08.5964354Z remote: Compressing objects: 54% (540/999) 2022-09-29T10:22:08.6030584Z remote: Compressing objects: 55% (550/999) 2022-09-29T10:22:08.6069819Z remote: Compressing objects: 56% (560/999) 2022-09-29T10:22:08.6114160Z remote: Compressing objects: 57% (570/999) 2022-09-29T10:22:08.6119846Z remote: Compressing objects: 58% (580/999) 2022-09-29T10:22:08.6124985Z remote: Compressing objects: 59% (590/999) 2022-09-29T10:22:08.6128657Z remote: Compressing objects: 60% (600/999) 2022-09-29T10:22:08.6146786Z remote: Compressing objects: 61% (610/999) 2022-09-29T10:22:08.6177726Z remote: Compressing objects: 62% (620/999) 2022-09-29T10:22:08.6183579Z remote: Compressing objects: 63% (630/999) 2022-09-29T10:22:08.6186133Z remote: Compressing objects: 64% (640/999) 2022-09-29T10:22:08.6201804Z remote: Compressing objects: 65% (650/999) 2022-09-29T10:22:08.6474644Z remote: Compressing objects: 66% (660/999) 2022-09-29T10:22:08.6475216Z remote: Compressing objects: 67% (670/999) 2022-09-29T10:22:08.6484086Z remote: Compressing objects: 68% (680/999) 2022-09-29T10:22:08.6489415Z remote: Compressing objects: 69% (690/999) 2022-09-29T10:22:08.6506948Z remote: Compressing objects: 70% (700/999) 2022-09-29T10:22:08.6516351Z remote: Compressing objects: 71% (710/999) 2022-09-29T10:22:08.6516808Z remote: Compressing objects: 72% (720/999) 2022-09-29T10:22:08.6520556Z remote: Compressing objects: 73% (730/999) 2022-09-29T10:22:08.6571220Z remote: Compressing objects: 74% (740/999) 2022-09-29T10:22:08.7043691Z remote: Compressing objects: 75% (750/999) 2022-09-29T10:22:08.7462279Z remote: Compressing objects: 76% (760/999) 2022-09-29T10:22:08.7742753Z remote: Compressing objects: 77% (770/999) 2022-09-29T10:22:08.7806754Z remote: Compressing objects: 78% (780/999) 2022-09-29T10:22:08.8038670Z remote: Compressing objects: 79% (790/999) 2022-09-29T10:22:08.8268429Z remote: Compressing objects: 80% (800/999) 2022-09-29T10:22:08.8449979Z remote: Compressing objects: 81% (810/999) 2022-09-29T10:22:08.8734136Z remote: Compressing objects: 82% (820/999) 2022-09-29T10:22:08.9335700Z remote: Compressing objects: 83% (830/999) 2022-09-29T10:22:08.9620258Z remote: Compressing objects: 84% (840/999) 2022-09-29T10:22:08.9876738Z remote: Compressing objects: 85% (850/999) 2022-09-29T10:22:08.9877348Z remote: Compressing objects: 86% (860/999) 2022-09-29T10:22:08.9877760Z remote: Compressing objects: 87% (870/999) 2022-09-29T10:22:08.9878455Z remote: Compressing objects: 88% (880/999) 2022-09-29T10:22:08.9879070Z remote: Compressing objects: 89% (890/999) 2022-09-29T10:22:08.9887924Z remote: Compressing objects: 90% (900/999) 2022-09-29T10:22:08.9888396Z remote: Compressing objects: 91% (910/999) 2022-09-29T10:22:08.9888838Z remote: Compressing objects: 92% (920/999) 2022-09-29T10:22:08.9892606Z remote: Compressing objects: 93% (930/999) 2022-09-29T10:22:08.9893423Z remote: Compressing objects: 94% (940/999) 2022-09-29T10:22:08.9894157Z remote: Compressing objects: 95% (950/999) 2022-09-29T10:22:08.9895261Z remote: Compressing objects: 96% (960/999) 2022-09-29T10:22:08.9895916Z remote: Compressing objects: 97% (970/999) 2022-09-29T10:22:08.9896322Z remote: Compressing objects: 98% (980/999) 2022-09-29T10:22:08.9896655Z remote: Compressing objects: 99% (990/999) 2022-09-29T10:22:08.9897030Z remote: Compressing objects: 100% (999/999) 2022-09-29T10:22:08.9897485Z remote: Compressing objects: 100% (999/999), done. 2022-09-29T10:22:09.0950750Z Receiving objects: 0% (1/1097) 2022-09-29T10:22:09.0959682Z Receiving objects: 1% (11/1097) 2022-09-29T10:22:09.0971507Z Receiving objects: 2% (22/1097) 2022-09-29T10:22:09.1237891Z Receiving objects: 3% (33/1097) 2022-09-29T10:22:09.1241486Z Receiving objects: 4% (44/1097) 2022-09-29T10:22:09.1242732Z Receiving objects: 5% (55/1097) 2022-09-29T10:22:09.1244547Z Receiving objects: 6% (66/1097) 2022-09-29T10:22:09.1244987Z Receiving objects: 7% (77/1097) 2022-09-29T10:22:09.1247839Z Receiving objects: 8% (88/1097) 2022-09-29T10:22:09.1251019Z Receiving objects: 9% (99/1097) 2022-09-29T10:22:09.1255478Z Receiving objects: 10% (110/1097) 2022-09-29T10:22:09.1262577Z Receiving objects: 11% (121/1097) 2022-09-29T10:22:09.1270999Z Receiving objects: 12% (132/1097) 2022-09-29T10:22:09.1276776Z Receiving objects: 13% (143/1097) 2022-09-29T10:22:09.1279189Z Receiving objects: 14% (154/1097) 2022-09-29T10:22:09.1281389Z Receiving objects: 15% (165/1097) 2022-09-29T10:22:09.1309688Z Receiving objects: 16% (176/1097) 2022-09-29T10:22:09.1328028Z Receiving objects: 17% (187/1097) 2022-09-29T10:22:09.1360888Z Receiving objects: 18% (198/1097) 2022-09-29T10:22:09.1363755Z Receiving objects: 19% (209/1097) 2022-09-29T10:22:09.1365017Z Receiving objects: 20% (220/1097) 2022-09-29T10:22:09.1483939Z Receiving objects: 21% (231/1097) 2022-09-29T10:22:09.1720677Z Receiving objects: 22% (242/1097) 2022-09-29T10:22:09.2029693Z Receiving objects: 23% (253/1097) 2022-09-29T10:22:09.2082186Z Receiving objects: 24% (264/1097) 2022-09-29T10:22:09.2164549Z Receiving objects: 25% (275/1097) 2022-09-29T10:22:09.2257450Z Receiving objects: 26% (286/1097) 2022-09-29T10:22:09.2395872Z Receiving objects: 27% (297/1097) 2022-09-29T10:22:09.2499400Z Receiving objects: 28% (308/1097) 2022-09-29T10:22:09.2992292Z Receiving objects: 29% (319/1097) 2022-09-29T10:22:09.3666124Z Receiving objects: 30% (330/1097) 2022-09-29T10:22:09.3715649Z Receiving objects: 31% (341/1097) 2022-09-29T10:22:09.4109253Z Receiving objects: 32% (352/1097) 2022-09-29T10:22:09.4171921Z Receiving objects: 33% (363/1097) 2022-09-29T10:22:09.4190283Z Receiving objects: 34% (373/1097) 2022-09-29T10:22:09.4194320Z Receiving objects: 35% (384/1097) 2022-09-29T10:22:09.4210716Z Receiving objects: 36% (395/1097) 2022-09-29T10:22:09.4228934Z Receiving objects: 37% (406/1097) 2022-09-29T10:22:09.4235756Z Receiving objects: 38% (417/1097) 2022-09-29T10:22:09.4242430Z Receiving objects: 39% (428/1097) 2022-09-29T10:22:09.4247323Z Receiving objects: 40% (439/1097) 2022-09-29T10:22:09.4261727Z Receiving objects: 41% (450/1097) 2022-09-29T10:22:09.4275807Z Receiving objects: 42% (461/1097) 2022-09-29T10:22:09.4279866Z Receiving objects: 43% (472/1097) 2022-09-29T10:22:09.4288968Z Receiving objects: 44% (483/1097) 2022-09-29T10:22:09.4296649Z Receiving objects: 45% (494/1097) 2022-09-29T10:22:09.4301464Z Receiving objects: 46% (505/1097) 2022-09-29T10:22:09.4302643Z Receiving objects: 47% (516/1097) 2022-09-29T10:22:09.4303783Z Receiving objects: 48% (527/1097) 2022-09-29T10:22:09.4305988Z Receiving objects: 49% (538/1097) 2022-09-29T10:22:09.4317984Z Receiving objects: 50% (549/1097) 2022-09-29T10:22:09.4325763Z Receiving objects: 51% (560/1097) 2022-09-29T10:22:09.4332634Z Receiving objects: 52% (571/1097) 2022-09-29T10:22:09.4340571Z Receiving objects: 53% (582/1097) 2022-09-29T10:22:09.4347465Z Receiving objects: 54% (593/1097) 2022-09-29T10:22:09.4357642Z Receiving objects: 55% (604/1097) 2022-09-29T10:22:09.4370769Z Receiving objects: 56% (615/1097) 2022-09-29T10:22:09.4399880Z Receiving objects: 57% (626/1097) 2022-09-29T10:22:09.4410256Z Receiving objects: 58% (637/1097) 2022-09-29T10:22:09.4418390Z Receiving objects: 59% (648/1097) 2022-09-29T10:22:09.4422307Z Receiving objects: 60% (659/1097) 2022-09-29T10:22:09.4429117Z Receiving objects: 61% (670/1097) 2022-09-29T10:22:09.4432192Z Receiving objects: 62% (681/1097) 2022-09-29T10:22:09.4438738Z Receiving objects: 63% (692/1097) 2022-09-29T10:22:09.4444558Z Receiving objects: 64% (703/1097) 2022-09-29T10:22:09.4453518Z Receiving objects: 65% (714/1097) 2022-09-29T10:22:09.4463568Z Receiving objects: 66% (725/1097) 2022-09-29T10:22:09.4480646Z Receiving objects: 67% (735/1097) 2022-09-29T10:22:09.4488558Z Receiving objects: 68% (746/1097) 2022-09-29T10:22:09.4489138Z Receiving objects: 69% (757/1097) 2022-09-29T10:22:09.4491849Z Receiving objects: 70% (768/1097) 2022-09-29T10:22:09.4497357Z Receiving objects: 71% (779/1097) 2022-09-29T10:22:09.4504935Z Receiving objects: 72% (790/1097) 2022-09-29T10:22:09.4522193Z Receiving objects: 73% (801/1097) 2022-09-29T10:22:09.4531890Z Receiving objects: 74% (812/1097) 2022-09-29T10:22:09.4541993Z Receiving objects: 75% (823/1097) 2022-09-29T10:22:09.4551583Z Receiving objects: 76% (834/1097) 2022-09-29T10:22:09.4560699Z Receiving objects: 77% (845/1097) 2022-09-29T10:22:09.4570573Z Receiving objects: 78% (856/1097) 2022-09-29T10:22:09.4589964Z Receiving objects: 79% (867/1097) 2022-09-29T10:22:09.4600474Z Receiving objects: 80% (878/1097) 2022-09-29T10:22:09.4609673Z Receiving objects: 81% (889/1097) 2022-09-29T10:22:09.4611810Z Receiving objects: 82% (900/1097) 2022-09-29T10:22:09.4616161Z Receiving objects: 83% (911/1097) 2022-09-29T10:22:09.4622784Z Receiving objects: 84% (922/1097) 2022-09-29T10:22:09.4634531Z Receiving objects: 85% (933/1097) 2022-09-29T10:22:09.4639821Z Receiving objects: 86% (944/1097) 2022-09-29T10:22:09.4646841Z Receiving objects: 87% (955/1097) 2022-09-29T10:22:09.4657736Z Receiving objects: 88% (966/1097) 2022-09-29T10:22:09.4663804Z Receiving objects: 89% (977/1097) 2022-09-29T10:22:09.4667998Z Receiving objects: 90% (988/1097) 2022-09-29T10:22:09.4675767Z Receiving objects: 91% (999/1097) 2022-09-29T10:22:09.4683785Z Receiving objects: 92% (1010/1097) 2022-09-29T10:22:09.4693316Z Receiving objects: 93% (1021/1097) 2022-09-29T10:22:09.4696490Z Receiving objects: 94% (1032/1097) 2022-09-29T10:22:09.4697911Z Receiving objects: 95% (1043/1097) 2022-09-29T10:22:09.4701194Z Receiving objects: 96% (1054/1097) 2022-09-29T10:22:09.4719445Z Receiving objects: 97% (1065/1097) 2022-09-29T10:22:09.4721490Z Receiving objects: 98% (1076/1097) 2022-09-29T10:22:09.4722647Z Receiving objects: 99% (1087/1097) 2022-09-29T10:22:09.4724237Z remote: Total 1097 (delta 120), reused 417 (delta 71), pack-reused 0 2022-09-29T10:22:09.4726079Z Receiving objects: 100% (1097/1097) 2022-09-29T10:22:09.4747487Z Receiving objects: 100% (1097/1097), 15.97 MiB | 39.41 MiB/s, done. 2022-09-29T10:22:09.4783831Z Resolving deltas: 0% (0/120) 2022-09-29T10:22:09.4803189Z Resolving deltas: 1% (2/120) 2022-09-29T10:22:09.4859373Z Resolving deltas: 2% (3/120) 2022-09-29T10:22:09.4885485Z Resolving deltas: 3% (4/120) 2022-09-29T10:22:09.4893269Z Resolving deltas: 4% (5/120) 2022-09-29T10:22:09.4915763Z Resolving deltas: 5% (6/120) 2022-09-29T10:22:09.4916254Z Resolving deltas: 6% (8/120) 2022-09-29T10:22:09.4916640Z Resolving deltas: 7% (9/120) 2022-09-29T10:22:09.4917026Z Resolving deltas: 8% (10/120) 2022-09-29T10:22:09.4917474Z Resolving deltas: 9% (11/120) 2022-09-29T10:22:09.4917865Z Resolving deltas: 10% (12/120) 2022-09-29T10:22:09.4918392Z Resolving deltas: 11% (14/120) 2022-09-29T10:22:09.4918796Z Resolving deltas: 12% (15/120) 2022-09-29T10:22:09.4919133Z Resolving deltas: 13% (16/120) 2022-09-29T10:22:09.4919509Z Resolving deltas: 14% (17/120) 2022-09-29T10:22:09.4919762Z Resolving deltas: 15% (18/120) 2022-09-29T10:22:09.4920092Z Resolving deltas: 16% (20/120) 2022-09-29T10:22:09.4920396Z Resolving deltas: 17% (21/120) 2022-09-29T10:22:09.4920706Z Resolving deltas: 18% (22/120) 2022-09-29T10:22:09.4920961Z Resolving deltas: 19% (23/120) 2022-09-29T10:22:09.4921270Z Resolving deltas: 20% (24/120) 2022-09-29T10:22:09.4921553Z Resolving deltas: 21% (26/120) 2022-09-29T10:22:09.4921784Z Resolving deltas: 22% (27/120) 2022-09-29T10:22:09.4922077Z Resolving deltas: 23% (28/120) 2022-09-29T10:22:09.4922368Z Resolving deltas: 24% (29/120) 2022-09-29T10:22:09.4922625Z Resolving deltas: 25% (30/120) 2022-09-29T10:22:09.4922897Z Resolving deltas: 26% (32/120) 2022-09-29T10:22:09.4923347Z Resolving deltas: 27% (33/120) 2022-09-29T10:22:09.4923597Z Resolving deltas: 28% (34/120) 2022-09-29T10:22:09.4923877Z Resolving deltas: 29% (35/120) 2022-09-29T10:22:09.4924163Z Resolving deltas: 30% (36/120) 2022-09-29T10:22:09.4924395Z Resolving deltas: 31% (38/120) 2022-09-29T10:22:09.4924671Z Resolving deltas: 32% (39/120) 2022-09-29T10:22:09.4924961Z Resolving deltas: 33% (40/120) 2022-09-29T10:22:09.4925199Z Resolving deltas: 34% (41/120) 2022-09-29T10:22:09.4925485Z Resolving deltas: 35% (42/120) 2022-09-29T10:22:09.4925773Z Resolving deltas: 36% (44/120) 2022-09-29T10:22:09.4926002Z Resolving deltas: 37% (45/120) 2022-09-29T10:22:09.4926282Z Resolving deltas: 38% (46/120) 2022-09-29T10:22:09.4926586Z Resolving deltas: 39% (47/120) 2022-09-29T10:22:09.4926892Z Resolving deltas: 40% (48/120) 2022-09-29T10:22:09.4927136Z Resolving deltas: 41% (50/120) 2022-09-29T10:22:09.4927407Z Resolving deltas: 42% (51/120) 2022-09-29T10:22:09.4927692Z Resolving deltas: 43% (52/120) 2022-09-29T10:22:09.4927945Z Resolving deltas: 44% (53/120) 2022-09-29T10:22:09.4928220Z Resolving deltas: 45% (54/120) 2022-09-29T10:22:09.4928494Z Resolving deltas: 46% (56/120) 2022-09-29T10:22:09.4928725Z Resolving deltas: 47% (57/120) 2022-09-29T10:22:09.4929005Z Resolving deltas: 48% (58/120) 2022-09-29T10:22:09.4929292Z Resolving deltas: 49% (59/120) 2022-09-29T10:22:09.4929526Z Resolving deltas: 50% (60/120) 2022-09-29T10:22:09.4929818Z Resolving deltas: 51% (62/120) 2022-09-29T10:22:09.4930119Z Resolving deltas: 52% (63/120) 2022-09-29T10:22:09.4930371Z Resolving deltas: 53% (64/120) 2022-09-29T10:22:09.4930669Z Resolving deltas: 54% (65/120) 2022-09-29T10:22:09.4930974Z Resolving deltas: 55% (66/120) 2022-09-29T10:22:09.4931215Z Resolving deltas: 56% (68/120) 2022-09-29T10:22:09.4931584Z Resolving deltas: 57% (69/120) 2022-09-29T10:22:09.4931924Z Resolving deltas: 58% (70/120) 2022-09-29T10:22:09.4932201Z Resolving deltas: 59% (71/120) 2022-09-29T10:22:09.4932490Z Resolving deltas: 60% (72/120) 2022-09-29T10:22:09.4932731Z Resolving deltas: 61% (74/120) 2022-09-29T10:22:09.4933038Z Resolving deltas: 62% (75/120) 2022-09-29T10:22:09.4933363Z Resolving deltas: 63% (76/120) 2022-09-29T10:22:09.4933610Z Resolving deltas: 64% (77/120) 2022-09-29T10:22:09.4933911Z Resolving deltas: 65% (78/120) 2022-09-29T10:22:09.4934225Z Resolving deltas: 66% (80/120) 2022-09-29T10:22:09.4934474Z Resolving deltas: 67% (81/120) 2022-09-29T10:22:09.4934789Z Resolving deltas: 68% (82/120) 2022-09-29T10:22:09.4935094Z Resolving deltas: 69% (83/120) 2022-09-29T10:22:09.4935340Z Resolving deltas: 70% (84/120) 2022-09-29T10:22:09.4935649Z Resolving deltas: 71% (86/120) 2022-09-29T10:22:09.4935967Z Resolving deltas: 72% (87/120) 2022-09-29T10:22:09.4936269Z Resolving deltas: 73% (88/120) 2022-09-29T10:22:09.4936526Z Resolving deltas: 74% (89/120) 2022-09-29T10:22:09.4936819Z Resolving deltas: 75% (90/120) 2022-09-29T10:22:09.4937095Z Resolving deltas: 76% (92/120) 2022-09-29T10:22:09.4937351Z Resolving deltas: 77% (93/120) 2022-09-29T10:22:09.4937649Z Resolving deltas: 78% (94/120) 2022-09-29T10:22:09.4937921Z Resolving deltas: 79% (95/120) 2022-09-29T10:22:09.4938157Z Resolving deltas: 80% (96/120) 2022-09-29T10:22:09.4938451Z Resolving deltas: 81% (98/120) 2022-09-29T10:22:09.4938733Z Resolving deltas: 82% (99/120) 2022-09-29T10:22:09.4938967Z Resolving deltas: 83% (100/120) 2022-09-29T10:22:09.4939273Z Resolving deltas: 84% (101/120) 2022-09-29T10:22:09.4939558Z Resolving deltas: 85% (102/120) 2022-09-29T10:22:09.4939797Z Resolving deltas: 86% (104/120) 2022-09-29T10:22:09.4940092Z Resolving deltas: 87% (105/120) 2022-09-29T10:22:09.4940380Z Resolving deltas: 88% (106/120) 2022-09-29T10:22:09.4940628Z Resolving deltas: 89% (107/120) 2022-09-29T10:22:09.4940921Z Resolving deltas: 90% (108/120) 2022-09-29T10:22:09.4941233Z Resolving deltas: 91% (110/120) 2022-09-29T10:22:09.4941485Z Resolving deltas: 92% (111/120) 2022-09-29T10:22:09.4941882Z Resolving deltas: 93% (112/120) 2022-09-29T10:22:09.4942208Z Resolving deltas: 94% (113/120) 2022-09-29T10:22:09.4942521Z Resolving deltas: 95% (114/120) 2022-09-29T10:22:09.4942818Z Resolving deltas: 96% (116/120) 2022-09-29T10:22:09.4943108Z Resolving deltas: 97% (117/120) 2022-09-29T10:22:09.4943400Z Resolving deltas: 98% (118/120) 2022-09-29T10:22:09.4943639Z Resolving deltas: 99% (119/120) 2022-09-29T10:22:09.4943941Z Resolving deltas: 100% (120/120) 2022-09-29T10:22:09.4944245Z Resolving deltas: 100% (120/120), done. 2022-09-29T10:22:09.5850038Z From https://github.com/QCoDeS/Qcodes 2022-09-29T10:22:09.5851197Z * [new ref] 26637f5615787b0af257bd88500545a92c7ac07e -> pull/4661/merge 2022-09-29T10:22:09.6100015Z ##[endgroup] 2022-09-29T10:22:09.6100928Z ##[group]Determining the checkout info 2022-09-29T10:22:09.6109452Z ##[endgroup] 2022-09-29T10:22:09.6110383Z ##[group]Checking out the ref 2022-09-29T10:22:09.6116323Z [command]"C:\Program Files\Git\bin\git.exe" checkout --progress --force refs/remotes/pull/4661/merge 2022-09-29T10:22:09.9969259Z Note: switching to 'refs/remotes/pull/4661/merge'. 2022-09-29T10:22:09.9970615Z 2022-09-29T10:22:09.9971915Z You are in 'detached HEAD' state. You can look around, make experimental 2022-09-29T10:22:09.9972565Z changes and commit them, and you can discard any commits you make in this 2022-09-29T10:22:09.9973094Z state without impacting any branches by switching back to a branch. 2022-09-29T10:22:09.9973426Z 2022-09-29T10:22:09.9973706Z If you want to create a new branch to retain commits you create, you may 2022-09-29T10:22:09.9974293Z do so (now or later) by using -c with the switch command. Example: 2022-09-29T10:22:09.9974604Z 2022-09-29T10:22:09.9974988Z git switch -c 2022-09-29T10:22:09.9975914Z 2022-09-29T10:22:09.9976152Z Or undo this operation with: 2022-09-29T10:22:09.9976424Z 2022-09-29T10:22:09.9976632Z git switch - 2022-09-29T10:22:09.9976878Z 2022-09-29T10:22:09.9977313Z Turn off this advice by setting config variable advice.detachedHead to false 2022-09-29T10:22:09.9977664Z 2022-09-29T10:22:09.9978013Z HEAD is now at 26637f5 Merge f05cb96e83a0959a0d5341d40f126141cf05261f into fa8fef99c2fc3a35fac0e8bebbbe996d5ad47a80 2022-09-29T10:22:10.0025190Z ##[endgroup] 2022-09-29T10:22:10.0025800Z ##[group]Setting up auth for fetching submodules 2022-09-29T10:22:10.0058264Z [command]"C:\Program Files\Git\bin\git.exe" config --global http.https://github.com/.extraheader "AUTHORIZATION: basic ***" 2022-09-29T10:22:10.0273248Z [command]"C:\Program Files\Git\bin\git.exe" config --global --unset-all url.https://github.com/.insteadOf 2022-09-29T10:22:10.0489463Z [command]"C:\Program Files\Git\bin\git.exe" config --global --add url.https://github.com/.insteadOf git@github.com: 2022-09-29T10:22:10.0704467Z [command]"C:\Program Files\Git\bin\git.exe" config --global --add url.https://github.com/.insteadOf org-20478252@github.com: 2022-09-29T10:22:10.0933046Z ##[endgroup] 2022-09-29T10:22:10.0933825Z ##[group]Fetching submodules 2022-09-29T10:22:10.0940387Z [command]"C:\Program Files\Git\bin\git.exe" submodule sync 2022-09-29T10:22:10.5381176Z [command]"C:\Program Files\Git\bin\git.exe" -c protocol.version=2 submodule update --init --force --depth=1 2022-09-29T10:22:10.9735304Z Submodule 'qcodes/tests/dataset/fixtures/db_files' (https://github.com/QCoDeS/qcodes_db_fixtures.git) registered for path 'qcodes/tests/dataset/fixtures/db_files' 2022-09-29T10:22:11.3602813Z Cloning into 'D:/a/Qcodes/Qcodes/qcodes/tests/dataset/fixtures/db_files'... 2022-09-29T10:22:11.4466596Z Submodule path 'qcodes/tests/dataset/fixtures/db_files': checked out '8949196ea30e5583a95edcb64b42d45e3968e862' 2022-09-29T10:22:11.4543664Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach "git config --local gc.auto 0" 2022-09-29T10:22:11.8826865Z Entering 'qcodes/tests/dataset/fixtures/db_files' 2022-09-29T10:22:11.9814534Z ##[endgroup] 2022-09-29T10:22:11.9816218Z ##[group]Persisting credentials for submodules 2022-09-29T10:22:11.9827293Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach --recursive "git config --local --name-only --get-regexp 'url\.https\:\/\/github\.com\/\.insteadOf' && git config --local --unset-all 'url.https://github.com/.insteadOf' || :" 2022-09-29T10:22:12.4143843Z Entering 'qcodes/tests/dataset/fixtures/db_files' 2022-09-29T10:22:12.4773691Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach "git config --local 'http.https://github.com/.extraheader' 'AUTHORIZATION: basic ***' && git config --local --show-origin --name-only --get-regexp remote.origin.url" 2022-09-29T10:22:12.9030798Z Entering 'qcodes/tests/dataset/fixtures/db_files' 2022-09-29T10:22:12.9656268Z file:D:/a/Qcodes/Qcodes/.git/modules/qcodes/tests/dataset/fixtures/db_files/config remote.origin.url 2022-09-29T10:22:12.9770232Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach "git config --local --add 'url.https://github.com/.insteadOf' 'git@github.com:'" 2022-09-29T10:22:13.4037479Z Entering 'qcodes/tests/dataset/fixtures/db_files' 2022-09-29T10:22:13.4481138Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach "git config --local --add 'url.https://github.com/.insteadOf' 'org-20478252@github.com:'" 2022-09-29T10:22:13.8754839Z Entering 'qcodes/tests/dataset/fixtures/db_files' 2022-09-29T10:22:13.9183353Z ##[endgroup] 2022-09-29T10:22:13.9545002Z [command]"C:\Program Files\Git\bin\git.exe" log -1 --format='%H' 2022-09-29T10:22:13.9752941Z '26637f5615787b0af257bd88500545a92c7ac07e' 2022-09-29T10:22:14.0613252Z ##[group]Run actions/setup-python@v4.2.0 2022-09-29T10:22:14.0613536Z with: 2022-09-29T10:22:14.0613733Z python-version: 3.10 2022-09-29T10:22:14.0613950Z cache: pip 2022-09-29T10:22:14.0614236Z cache-dependency-path: pyproject.toml requirements.txt 2022-09-29T10:22:14.0614666Z check-latest: false 2022-09-29T10:22:14.0615088Z token: *** 2022-09-29T10:22:14.0615278Z update-environment: true 2022-09-29T10:22:14.0615473Z env: 2022-09-29T10:22:14.0615645Z DISPLAY: :99.0 2022-09-29T10:22:14.0615829Z OS: windows-latest 2022-09-29T10:22:14.0616025Z PYTHON: 3.10 2022-09-29T10:22:14.0616208Z ##[endgroup] 2022-09-29T10:22:14.5031497Z 2022-09-29T10:22:14.5035435Z 2022-09-29T10:22:14.5037913Z Successfully set up CPython (3.10.7) 2022-09-29T10:22:29.8181472Z Received 104857600 of 161016375 (65.1%), 100.0 MBs/sec 2022-09-29T10:22:30.8321126Z Received 156822071 of 161016375 (97.4%), 74.3 MBs/sec 2022-09-29T10:22:31.8441172Z Received 156822071 of 161016375 (97.4%), 49.4 MBs/sec 2022-09-29T10:22:32.7194232Z Received 161016375 of 161016375 (100.0%), 40.6 MBs/sec 2022-09-29T10:22:32.7194629Z Cache Size: ~154 MB (161016375 B) 2022-09-29T10:22:32.7195518Z [command]C:\Windows\System32\tar.exe -z -xf D:/a/_temp/5e66629c-402d-4898-b5ed-204d5a1a8fdd/cache.tgz -P -C D:/a/Qcodes/Qcodes 2022-09-29T10:22:36.3531799Z Cache restored successfully 2022-09-29T10:22:36.3708087Z Cache restored from key: setup-python-Windows-python-3.10.7-pip-e4a24637bc91b7a51539ea35c8ece3d91176102d6e282ee81f5a0b1544cc1c80 2022-09-29T10:22:36.3708710Z 2022-09-29T10:22:36.4100092Z ##[group]Run python -m pip install --upgrade pip setuptools wheel 2022-09-29T10:22:36.4100666Z python -m pip install --upgrade pip setuptools wheel 2022-09-29T10:22:36.4119069Z shell: C:\Program Files\Git\bin\bash.EXE --noprofile --norc -e -o pipefail {0} 2022-09-29T10:22:36.4119397Z env: 2022-09-29T10:22:36.4119615Z DISPLAY: :99.0 2022-09-29T10:22:36.4119843Z OS: windows-latest 2022-09-29T10:22:36.4120063Z PYTHON: 3.10 2022-09-29T10:22:36.4120362Z pythonLocation: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:22:36.4120731Z PKG_CONFIG_PATH: C:\hostedtoolcache\windows\Python\3.10.7\x64/lib/pkgconfig 2022-09-29T10:22:36.4121119Z Python_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:22:36.4121487Z Python2_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:22:36.4121843Z Python3_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:22:36.4122121Z ##[endgroup] 2022-09-29T10:22:39.9239542Z Requirement already satisfied: pip in c:\hostedtoolcache\windows\python\3.10.7\x64\lib\site-packages (22.2.2) 2022-09-29T10:22:41.1455654Z Requirement already satisfied: setuptools in c:\hostedtoolcache\windows\python\3.10.7\x64\lib\site-packages (63.2.0) 2022-09-29T10:22:41.3494941Z Collecting setuptools 2022-09-29T10:22:41.3552438Z Using cached setuptools-65.4.0-py3-none-any.whl (1.2 MB) 2022-09-29T10:22:41.4143982Z Collecting wheel 2022-09-29T10:22:41.4170050Z Using cached wheel-0.37.1-py2.py3-none-any.whl (35 kB) 2022-09-29T10:22:41.5691886Z Installing collected packages: wheel, setuptools 2022-09-29T10:22:41.8526368Z Attempting uninstall: setuptools 2022-09-29T10:22:41.8537262Z Found existing installation: setuptools 63.2.0 2022-09-29T10:22:44.3692647Z Uninstalling setuptools-63.2.0: 2022-09-29T10:22:44.5213659Z Successfully uninstalled setuptools-63.2.0 2022-09-29T10:22:47.3895271Z Successfully installed setuptools-65.4.0 wheel-0.37.1 2022-09-29T10:22:48.0590037Z ##[group]Run pip install .[test] -c requirements.txt 2022-09-29T10:22:48.0590487Z pip install .[test] -c requirements.txt 2022-09-29T10:22:48.0771701Z shell: C:\Program Files\PowerShell\7\pwsh.EXE -command ". '{0}'" 2022-09-29T10:22:48.0772000Z env: 2022-09-29T10:22:48.0772212Z DISPLAY: :99.0 2022-09-29T10:22:48.0772435Z OS: windows-latest 2022-09-29T10:22:48.0772653Z PYTHON: 3.10 2022-09-29T10:22:48.0772949Z pythonLocation: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:22:48.0773338Z PKG_CONFIG_PATH: C:\hostedtoolcache\windows\Python\3.10.7\x64/lib/pkgconfig 2022-09-29T10:22:48.0773699Z Python_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:22:48.0774055Z Python2_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:22:48.0774519Z Python3_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:22:48.0774800Z ##[endgroup] 2022-09-29T10:22:57.6948911Z Processing d:\a\qcodes\qcodes 2022-09-29T10:22:57.7010384Z Installing build dependencies: started 2022-09-29T10:23:01.5346781Z Installing build dependencies: finished with status 'done' 2022-09-29T10:23:01.5364442Z Getting requirements to build wheel: started 2022-09-29T10:23:03.3114478Z Getting requirements to build wheel: finished with status 'done' 2022-09-29T10:23:03.3170937Z Preparing metadata (pyproject.toml): started 2022-09-29T10:23:04.1347608Z Preparing metadata (pyproject.toml): finished with status 'done' 2022-09-29T10:23:04.2624418Z Collecting uncertainties>=3.1.4 2022-09-29T10:23:04.2653219Z Using cached uncertainties-3.1.7-py2.py3-none-any.whl (98 kB) 2022-09-29T10:23:04.2951723Z Collecting h5netcdf!=0.14.0,>=0.10.0 2022-09-29T10:23:04.2976403Z Using cached h5netcdf-0.15.0-py2.py3-none-any.whl (24 kB) 2022-09-29T10:23:04.3249510Z Collecting opencensus-ext-azure<2.0.0,>=1.0.4 2022-09-29T10:23:04.3273641Z Using cached opencensus_ext_azure-1.1.7-py2.py3-none-any.whl (42 kB) 2022-09-29T10:23:04.3650801Z Collecting jsonschema>=3.0.0 2022-09-29T10:23:04.3676384Z Using cached jsonschema-4.16.0-py3-none-any.whl (83 kB) 2022-09-29T10:23:04.4364236Z Collecting wrapt>=1.10.4 2022-09-29T10:23:04.4390291Z Using cached wrapt-1.14.1-cp310-cp310-win_amd64.whl (35 kB) 2022-09-29T10:23:04.4748505Z Collecting packaging>=20.0 2022-09-29T10:23:04.4772059Z Using cached packaging-21.3-py3-none-any.whl (40 kB) 2022-09-29T10:23:04.5073011Z Collecting rsa>=4.7 2022-09-29T10:23:04.5097830Z Using cached rsa-4.9-py3-none-any.whl (34 kB) 2022-09-29T10:23:04.5896412Z Collecting ipython!=8.0.0,>=7.31.1 2022-09-29T10:23:04.5947021Z Using cached ipython-8.5.0-py3-none-any.whl (752 kB) 2022-09-29T10:23:04.6495262Z Collecting h5py>=3.0.0 2022-09-29T10:23:04.6576505Z Using cached h5py-3.7.0-cp310-cp310-win_amd64.whl (2.6 MB) 2022-09-29T10:23:04.6928965Z Collecting broadbean>=0.9.1 2022-09-29T10:23:04.6954372Z Using cached broadbean-0.11.0-py3-none-any.whl (48 kB) 2022-09-29T10:23:04.9234147Z Collecting ruamel.yaml!=0.16.6,>=0.16.0 2022-09-29T10:23:04.9267553Z Using cached ruamel.yaml-0.17.21-py3-none-any.whl (109 kB) 2022-09-29T10:23:04.9549682Z Collecting opencensus>=0.7.10 2022-09-29T10:23:04.9576221Z Using cached opencensus-0.11.0-py2.py3-none-any.whl (128 kB) 2022-09-29T10:23:04.9816212Z Collecting pyvisa<1.13.0,>=1.11.0 2022-09-29T10:23:04.9855329Z Using cached PyVISA-1.12.0-py3-none-any.whl (175 kB) 2022-09-29T10:23:05.0591493Z Collecting tqdm>=4.32.2 2022-09-29T10:23:05.0620336Z Using cached tqdm-4.64.1-py2.py3-none-any.whl (78 kB) 2022-09-29T10:23:05.1055945Z Collecting ipywidgets<9.0.0,>=7.5.0 2022-09-29T10:23:05.1082319Z Using cached ipywidgets-8.0.2-py3-none-any.whl (134 kB) 2022-09-29T10:23:05.2169848Z Collecting matplotlib>=3.3.0 2022-09-29T10:23:05.2348748Z Using cached matplotlib-3.6.0-cp310-cp310-win_amd64.whl (7.2 MB) 2022-09-29T10:23:05.3330508Z Collecting websockets>=7.0 2022-09-29T10:23:05.3361514Z Using cached websockets-10.3-cp310-cp310-win_amd64.whl (98 kB) 2022-09-29T10:23:05.5200915Z Collecting numpy>=1.21.0 2022-09-29T10:23:05.5528228Z Using cached numpy-1.23.3-cp310-cp310-win_amd64.whl (14.6 MB) 2022-09-29T10:23:05.6742130Z Collecting xarray>=0.18.0 2022-09-29T10:23:05.6796526Z Using cached xarray-2022.6.0-py3-none-any.whl (927 kB) 2022-09-29T10:23:05.7074171Z Collecting tabulate>=0.8.0 2022-09-29T10:23:05.7104506Z Using cached tabulate-0.8.10-py3-none-any.whl (29 kB) 2022-09-29T10:23:05.7374718Z Collecting typing-extensions>=3.10.0 2022-09-29T10:23:05.7399343Z Using cached typing_extensions-4.3.0-py3-none-any.whl (25 kB) 2022-09-29T10:23:05.9106479Z Collecting pillow>=9.0.0 2022-09-29T10:23:05.9206180Z Using cached Pillow-9.2.0-cp310-cp310-win_amd64.whl (3.3 MB) 2022-09-29T10:23:06.0625889Z Collecting pandas>=1.0.0 2022-09-29T10:23:06.0937842Z Using cached pandas-1.5.0-cp310-cp310-win_amd64.whl (10.4 MB) 2022-09-29T10:23:06.1884413Z Collecting versioningit>=2.0.1 2022-09-29T10:23:06.1912112Z Using cached versioningit-2.0.1-py3-none-any.whl (32 kB) 2022-09-29T10:23:06.2207342Z Collecting types-tqdm>=4.64.6 2022-09-29T10:23:06.2234141Z Using cached types_tqdm-4.64.7-py3-none-any.whl (18 kB) 2022-09-29T10:23:06.3137615Z Collecting pytest>=6.0.0 2022-09-29T10:23:06.3173029Z Using cached pytest-7.1.3-py3-none-any.whl (298 kB) 2022-09-29T10:23:06.8323568Z Collecting hypothesis>=5.49.0 2022-09-29T10:23:06.8368464Z Using cached hypothesis-6.54.6-py3-none-any.whl (390 kB) 2022-09-29T10:23:06.8917479Z Collecting deepdiff>=5.0.2 2022-09-29T10:23:06.8946791Z Using cached deepdiff-5.8.1-py3-none-any.whl (69 kB) 2022-09-29T10:23:06.9763987Z Collecting mypy>=0.971 2022-09-29T10:23:06.9966835Z Using cached mypy-0.981-cp310-cp310-win_amd64.whl (8.5 MB) 2022-09-29T10:23:07.2482324Z Collecting coverage[toml]>=6.0.0 2022-09-29T10:23:07.2517494Z Using cached coverage-6.4.4-cp310-cp310-win_amd64.whl (187 kB) 2022-09-29T10:23:07.2793689Z Collecting types-jsonschema>=4.16.0 2022-09-29T10:23:07.2818581Z Using cached types_jsonschema-4.16.1-py3-none-any.whl (8.7 kB) 2022-09-29T10:23:07.3118070Z Collecting types-setuptools>=57.0.0 2022-09-29T10:23:07.3143445Z Using cached types_setuptools-65.3.0-py3-none-any.whl (49 kB) 2022-09-29T10:23:07.3454384Z Collecting pytest-cov>=3.0.0 2022-09-29T10:23:07.3479635Z Using cached pytest_cov-4.0.0-py3-none-any.whl (21 kB) 2022-09-29T10:23:07.3800707Z Collecting types-requests>=0.1.8 2022-09-29T10:23:07.3827280Z Using cached types_requests-2.28.11-py3-none-any.whl (13 kB) 2022-09-29T10:23:07.3868595Z Collecting sphinx>=4.5.0 2022-09-29T10:23:07.3874564Z Cloning https://github.com/jenshnielsen/sphinx.git (to revision fix_9884_50branch) to c:\users\runneradmin\appdata\local\temp\pip-install-00sg7l9g\sphinx_40337c060af74fa8a99ad62eb86fdc4e 2022-09-29T10:23:07.4101332Z Running command git clone --filter=blob:none --quiet https://github.com/jenshnielsen/sphinx.git 'C:\Users\runneradmin\AppData\Local\Temp\pip-install-00sg7l9g\sphinx_40337c060af74fa8a99ad62eb86fdc4e' 2022-09-29T10:23:11.0541451Z Running command git checkout -b fix_9884_50branch --track origin/fix_9884_50branch 2022-09-29T10:23:14.3973014Z branch 'fix_9884_50branch' set up to track 'origin/fix_9884_50branch'. 2022-09-29T10:23:14.3973756Z Switched to a new branch 'fix_9884_50branch' 2022-09-29T10:23:14.4016496Z Resolved https://github.com/jenshnielsen/sphinx.git to commit 46ad272b96ff04936caa39c6ad95e884366370bc 2022-09-29T10:23:14.4258718Z Preparing metadata (setup.py): started 2022-09-29T10:23:15.2652171Z Preparing metadata (setup.py): finished with status 'done' 2022-09-29T10:23:15.2670406Z WARNING: Requested sphinx>=4.5.0 from git+https://github.com/jenshnielsen/sphinx.git@fix_9884_50branch (from qcodes==0.0), but installing version 5.0.3.dev20220929 2022-09-29T10:23:15.3697980Z Collecting PyVisa-sim>=0.4.0 2022-09-29T10:23:15.3727996Z Using cached PyVISA_sim-0.5.1-py3-none-any.whl (27 kB) 2022-09-29T10:23:15.3971676Z Collecting types-tabulate>=0.1.0 2022-09-29T10:23:15.4001305Z Using cached types_tabulate-0.8.11-py3-none-any.whl (2.6 kB) 2022-09-29T10:23:15.5693594Z Collecting lxml>=4.3.0 2022-09-29T10:23:15.5806673Z Using cached lxml-4.9.1-cp310-cp310-win_amd64.whl (3.6 MB) 2022-09-29T10:23:15.6728059Z Collecting slack-sdk>=3.4.2 2022-09-29T10:23:15.6761072Z Using cached slack_sdk-3.18.3-py2.py3-none-any.whl (266 kB) 2022-09-29T10:23:15.7360790Z Collecting pandas-stubs>=1.2.0.1 2022-09-29T10:23:15.7395922Z Using cached pandas_stubs-1.5.0.220926-py3-none-any.whl (136 kB) 2022-09-29T10:23:15.7603149Z Collecting lxml-stubs>=0.4.0 2022-09-29T10:23:15.7627093Z Using cached lxml_stubs-0.4.0-py3-none-any.whl (13 kB) 2022-09-29T10:23:15.8174660Z Collecting PyQt5>=5.15.0 2022-09-29T10:23:15.8338816Z Using cached PyQt5-5.15.7-cp37-abi3-win_amd64.whl (6.8 MB) 2022-09-29T10:23:15.9021323Z Collecting pyqtgraph>=0.11.0 2022-09-29T10:23:15.9074930Z Using cached pyqtgraph-0.13.1-py3-none-any.whl (966 kB) 2022-09-29T10:23:15.9668944Z Collecting pytest-mock>=3.0.0 2022-09-29T10:23:15.9693090Z Using cached pytest_mock-3.9.0-py3-none-any.whl (9.1 kB) 2022-09-29T10:23:16.0071319Z Collecting pytest-xdist>=2.0.0 2022-09-29T10:23:16.0096369Z Using cached pytest_xdist-2.5.0-py3-none-any.whl (41 kB) 2022-09-29T10:23:16.0436744Z Collecting pytest-rerunfailures>=5.0.0 2022-09-29T10:23:16.0462187Z Using cached pytest_rerunfailures-10.2-py3-none-any.whl (11 kB) 2022-09-29T10:23:16.0882119Z Collecting schema 2022-09-29T10:23:16.0906456Z Using cached schema-0.7.5-py2.py3-none-any.whl (17 kB) 2022-09-29T10:23:16.1301613Z Collecting tomli 2022-09-29T10:23:16.1325792Z Using cached tomli-2.0.1-py3-none-any.whl (12 kB) 2022-09-29T10:23:16.1578108Z Collecting ordered-set<4.2.0,>=4.1.0 2022-09-29T10:23:16.1601857Z Using cached ordered_set-4.1.0-py3-none-any.whl (7.6 kB) 2022-09-29T10:23:16.2448081Z Collecting exceptiongroup>=1.0.0rc8 2022-09-29T10:23:16.2473417Z Using cached exceptiongroup-1.0.0rc9-py3-none-any.whl (12 kB) 2022-09-29T10:23:16.2738971Z Collecting attrs>=19.2.0 2022-09-29T10:23:16.2765002Z Using cached attrs-22.1.0-py2.py3-none-any.whl (58 kB) 2022-09-29T10:23:16.3259300Z Collecting sortedcontainers<3.0.0,>=2.1.0 2022-09-29T10:23:16.3287403Z Using cached sortedcontainers-2.4.0-py2.py3-none-any.whl (29 kB) 2022-09-29T10:23:16.4582382Z Collecting pygments>=2.4.0 2022-09-29T10:23:16.4634008Z Using cached Pygments-2.13.0-py3-none-any.whl (1.1 MB) 2022-09-29T10:23:16.5022997Z Collecting pickleshare 2022-09-29T10:23:16.5047390Z Using cached pickleshare-0.7.5-py2.py3-none-any.whl (6.9 kB) 2022-09-29T10:23:16.5549564Z Collecting prompt-toolkit<3.1.0,>3.0.1 2022-09-29T10:23:16.5586875Z Using cached prompt_toolkit-3.0.31-py3-none-any.whl (382 kB) 2022-09-29T10:23:16.6090045Z Collecting jedi>=0.16 2022-09-29T10:23:16.6145277Z Using cached jedi-0.18.1-py2.py3-none-any.whl (1.6 MB) 2022-09-29T10:23:16.6663277Z Collecting traitlets>=5 2022-09-29T10:23:16.6689799Z Using cached traitlets-5.4.0-py3-none-any.whl (107 kB) 2022-09-29T10:23:16.7002489Z Collecting backcall 2022-09-29T10:23:16.7025935Z Using cached backcall-0.2.0-py2.py3-none-any.whl (11 kB) 2022-09-29T10:23:16.7298054Z Collecting decorator 2022-09-29T10:23:16.7321727Z Using cached decorator-5.1.1-py3-none-any.whl (9.1 kB) 2022-09-29T10:23:16.7728777Z Collecting stack-data 2022-09-29T10:23:16.7756654Z Using cached stack_data-0.5.1-py3-none-any.whl (24 kB) 2022-09-29T10:23:16.8094699Z Collecting colorama 2022-09-29T10:23:16.8119711Z Using cached colorama-0.4.5-py2.py3-none-any.whl (16 kB) 2022-09-29T10:23:16.8395131Z Collecting matplotlib-inline 2022-09-29T10:23:16.8418442Z Using cached matplotlib_inline-0.1.6-py3-none-any.whl (9.4 kB) 2022-09-29T10:23:16.9229769Z Collecting ipykernel>=4.5.1 2022-09-29T10:23:16.9256571Z Using cached ipykernel-6.16.0-py3-none-any.whl (138 kB) 2022-09-29T10:23:16.9857367Z Collecting widgetsnbextension~=4.0 2022-09-29T10:23:16.9928506Z Using cached widgetsnbextension-4.0.3-py3-none-any.whl (2.0 MB) 2022-09-29T10:23:17.0531938Z Collecting jupyterlab-widgets~=3.0 2022-09-29T10:23:17.0564925Z Using cached jupyterlab_widgets-3.0.3-py3-none-any.whl (384 kB) 2022-09-29T10:23:17.1238085Z Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 2022-09-29T10:23:17.1265548Z Using cached pyrsistent-0.18.1-cp310-cp310-win_amd64.whl (61 kB) 2022-09-29T10:23:17.1998820Z Collecting contourpy>=1.0.1 2022-09-29T10:23:17.2026722Z Using cached contourpy-1.0.5-cp310-cp310-win_amd64.whl (164 kB) 2022-09-29T10:23:17.3028950Z Collecting fonttools>=4.22.0 2022-09-29T10:23:17.3081474Z Using cached fonttools-4.37.3-py3-none-any.whl (959 kB) 2022-09-29T10:23:17.3438632Z Collecting python-dateutil>=2.7 2022-09-29T10:23:17.3467680Z Using cached python_dateutil-2.8.2-py2.py3-none-any.whl (247 kB) 2022-09-29T10:23:17.4099193Z Collecting kiwisolver>=1.0.1 2022-09-29T10:23:17.4128778Z Using cached kiwisolver-1.4.4-cp310-cp310-win_amd64.whl (55 kB) 2022-09-29T10:23:17.4321421Z Collecting cycler>=0.10 2022-09-29T10:23:17.4345798Z Using cached cycler-0.11.0-py3-none-any.whl (6.4 kB) 2022-09-29T10:23:17.5043150Z Collecting pyparsing>=2.2.1 2022-09-29T10:23:17.5074041Z Using cached pyparsing-3.0.9-py3-none-any.whl (98 kB) 2022-09-29T10:23:17.5406597Z Collecting mypy-extensions>=0.4.3 2022-09-29T10:23:17.5430833Z Using cached mypy_extensions-0.4.3-py2.py3-none-any.whl (4.5 kB) 2022-09-29T10:23:17.6417650Z Collecting google-api-core<3.0.0,>=1.0.0 2022-09-29T10:23:17.6444640Z Using cached google_api_core-2.10.1-py3-none-any.whl (115 kB) 2022-09-29T10:23:17.6651439Z Collecting opencensus-context>=0.1.3 2022-09-29T10:23:17.6674982Z Using cached opencensus_context-0.1.3-py2.py3-none-any.whl (5.1 kB) 2022-09-29T10:23:17.7106749Z Collecting azure-identity<2.0.0,>=1.5.0 2022-09-29T10:23:17.7142589Z Using cached azure_identity-1.11.0-py3-none-any.whl (136 kB) 2022-09-29T10:23:17.7683207Z Collecting requests>=2.19.0 2022-09-29T10:23:17.7711534Z Using cached requests-2.28.1-py3-none-any.whl (62 kB) 2022-09-29T10:23:17.8104338Z Collecting azure-core<2.0.0,>=1.12.0 2022-09-29T10:23:17.8130673Z Using cached azure_core-1.25.1-py3-none-any.whl (178 kB) 2022-09-29T10:23:17.9149917Z Collecting psutil>=5.6.3 2022-09-29T10:23:17.9179128Z Using cached psutil-5.9.2-cp310-cp310-win_amd64.whl (245 kB) 2022-09-29T10:23:18.0182103Z Collecting pytz>=2020.1 2022-09-29T10:23:18.0223953Z Using cached pytz-2022.2.1-py2.py3-none-any.whl (500 kB) 2022-09-29T10:23:18.0616708Z Collecting types-pytz>=2022.1.1 2022-09-29T10:23:18.0641438Z Using cached types_pytz-2022.2.1.0-py3-none-any.whl (4.5 kB) 2022-09-29T10:23:18.1336137Z Collecting PyQt5-sip<13,>=12.11 2022-09-29T10:23:18.1362321Z Using cached PyQt5_sip-12.11.0-cp310-cp310-win_amd64.whl (78 kB) 2022-09-29T10:23:18.1571556Z Collecting PyQt5-Qt5>=5.15.0 2022-09-29T10:23:18.2637242Z Using cached PyQt5_Qt5-5.15.2-py3-none-win_amd64.whl (50.1 MB) 2022-09-29T10:23:18.6061864Z Collecting iniconfig 2022-09-29T10:23:18.6091118Z Using cached iniconfig-1.1.1-py2.py3-none-any.whl (5.0 kB) 2022-09-29T10:23:18.6396002Z Collecting py>=1.8.2 2022-09-29T10:23:18.6421961Z Using cached py-1.11.0-py2.py3-none-any.whl (98 kB) 2022-09-29T10:23:18.6786163Z Collecting pluggy<2.0,>=0.12 2022-09-29T10:23:18.7079155Z Using cached pluggy-1.0.0-py2.py3-none-any.whl (13 kB) 2022-09-29T10:23:18.7507544Z Requirement already satisfied: setuptools>=40.0 in c:\hostedtoolcache\windows\python\3.10.7\x64\lib\site-packages (from pytest-rerunfailures>=5.0.0->qcodes==0.0) (65.4.0) 2022-09-29T10:23:18.7772387Z Collecting pytest-forked 2022-09-29T10:23:18.7798944Z Using cached pytest_forked-1.4.0-py3-none-any.whl (4.9 kB) 2022-09-29T10:23:18.8253414Z Collecting execnet>=1.1 2022-09-29T10:23:18.8279162Z Using cached execnet-1.9.0-py2.py3-none-any.whl (39 kB) 2022-09-29T10:23:18.9468368Z Collecting PyYAML 2022-09-29T10:23:18.9500427Z Using cached PyYAML-6.0-cp310-cp310-win_amd64.whl (151 kB) 2022-09-29T10:23:18.9789217Z Collecting stringparser 2022-09-29T10:23:18.9790760Z Using cached stringparser-0.5-py3-none-any.whl 2022-09-29T10:23:19.0711260Z Collecting pyasn1>=0.1.3 2022-09-29T10:23:19.0740625Z Using cached pyasn1-0.4.8-py2.py3-none-any.whl (77 kB) 2022-09-29T10:23:19.1150007Z Collecting ruamel.yaml.clib>=0.2.6 2022-09-29T10:23:19.1183376Z Using cached ruamel.yaml.clib-0.2.6-cp310-cp310-win_amd64.whl (118 kB) 2022-09-29T10:23:19.1934758Z Collecting sphinxcontrib-applehelp 2022-09-29T10:23:19.1961459Z Using cached sphinxcontrib_applehelp-1.0.2-py2.py3-none-any.whl (121 kB) 2022-09-29T10:23:19.2180279Z Collecting sphinxcontrib-devhelp 2022-09-29T10:23:19.2205179Z Using cached sphinxcontrib_devhelp-1.0.2-py2.py3-none-any.whl (84 kB) 2022-09-29T10:23:19.2624248Z Collecting sphinxcontrib-jsmath 2022-09-29T10:23:19.2648939Z Using cached sphinxcontrib_jsmath-1.0.1-py2.py3-none-any.whl (5.1 kB) 2022-09-29T10:23:19.2836973Z Collecting sphinxcontrib-htmlhelp>=2.0.0 2022-09-29T10:23:19.2861957Z Using cached sphinxcontrib_htmlhelp-2.0.0-py2.py3-none-any.whl (100 kB) 2022-09-29T10:23:19.3174603Z Collecting sphinxcontrib-serializinghtml>=1.1.5 2022-09-29T10:23:19.3199630Z Using cached sphinxcontrib_serializinghtml-1.1.5-py2.py3-none-any.whl (94 kB) 2022-09-29T10:23:19.3405257Z Collecting sphinxcontrib-qthelp 2022-09-29T10:23:19.3429188Z Using cached sphinxcontrib_qthelp-1.0.3-py2.py3-none-any.whl (90 kB) 2022-09-29T10:23:19.3830663Z Collecting Jinja2>=2.3 2022-09-29T10:23:19.3856695Z Using cached Jinja2-3.1.2-py3-none-any.whl (133 kB) 2022-09-29T10:23:19.4195163Z Collecting docutils<0.19,>=0.14 2022-09-29T10:23:19.4238698Z Using cached docutils-0.17.1-py2.py3-none-any.whl (575 kB) 2022-09-29T10:23:19.4594739Z Collecting snowballstemmer>=1.1 2022-09-29T10:23:19.4622135Z Using cached snowballstemmer-2.2.0-py2.py3-none-any.whl (93 kB) 2022-09-29T10:23:19.4884449Z Collecting babel>=1.3 2022-09-29T10:23:19.5105427Z Using cached Babel-2.10.3-py3-none-any.whl (9.5 MB) 2022-09-29T10:23:19.5939801Z Collecting alabaster<0.8,>=0.7 2022-09-29T10:23:19.5965770Z Using cached alabaster-0.7.12-py2.py3-none-any.whl (14 kB) 2022-09-29T10:23:19.6184298Z Collecting imagesize 2022-09-29T10:23:19.6208211Z Using cached imagesize-1.4.1-py2.py3-none-any.whl (8.8 kB) 2022-09-29T10:23:19.7241790Z Collecting types-urllib3<1.27 2022-09-29T10:23:19.7267203Z Using cached types_urllib3-1.26.25-py3-none-any.whl (14 kB) 2022-09-29T10:23:19.8323443Z Collecting future 2022-09-29T10:23:19.8325111Z Using cached future-0.18.2-py3-none-any.whl 2022-09-29T10:23:19.9985465Z Collecting six>=1.11.0 2022-09-29T10:23:20.0010570Z Using cached six-1.16.0-py2.py3-none-any.whl (11 kB) 2022-09-29T10:23:20.0702841Z Collecting msal<2.0.0,>=1.12.0 2022-09-29T10:23:20.0729023Z Using cached msal-1.19.0-py2.py3-none-any.whl (83 kB) 2022-09-29T10:23:20.0968194Z Collecting msal-extensions<2.0.0,>=0.3.0 2022-09-29T10:23:20.0991565Z Using cached msal_extensions-1.0.0-py2.py3-none-any.whl (19 kB) 2022-09-29T10:23:20.2680414Z Collecting cryptography>=2.5 2022-09-29T10:23:20.2761485Z Using cached cryptography-38.0.1-cp36-abi3-win_amd64.whl (2.4 MB) 2022-09-29T10:23:20.5330549Z Collecting google-auth<3.0dev,>=1.25.0 2022-09-29T10:23:20.5359184Z Using cached google_auth-2.12.0-py2.py3-none-any.whl (169 kB) 2022-09-29T10:23:20.6930887Z Collecting protobuf<5.0.0dev,>=3.20.1 2022-09-29T10:23:20.6969178Z Using cached protobuf-4.21.6-cp310-abi3-win_amd64.whl (525 kB) 2022-09-29T10:23:20.7266035Z Collecting googleapis-common-protos<2.0dev,>=1.56.2 2022-09-29T10:23:20.7292528Z Using cached googleapis_common_protos-1.56.4-py2.py3-none-any.whl (211 kB) 2022-09-29T10:23:20.8229851Z Collecting tornado>=6.1 2022-09-29T10:23:20.8262946Z Using cached tornado-6.2-cp37-abi3-win_amd64.whl (425 kB) 2022-09-29T10:23:20.9791511Z Collecting pyzmq>=17 2022-09-29T10:23:20.9851599Z Using cached pyzmq-24.0.1-cp310-cp310-win_amd64.whl (992 kB) 2022-09-29T10:23:21.0285457Z Collecting nest-asyncio 2022-09-29T10:23:21.0311141Z Using cached nest_asyncio-1.5.5-py3-none-any.whl (5.2 kB) 2022-09-29T10:23:21.0707353Z Collecting jupyter-client>=6.1.12 2022-09-29T10:23:21.0736953Z Using cached jupyter_client-7.3.5-py3-none-any.whl (132 kB) 2022-09-29T10:23:21.2271952Z Collecting debugpy>=1.0 2022-09-29T10:23:21.2403060Z Using cached debugpy-1.6.3-cp310-cp310-win_amd64.whl (4.6 MB) 2022-09-29T10:23:21.3165853Z Collecting parso<0.9.0,>=0.8.0 2022-09-29T10:23:21.3191861Z Using cached parso-0.8.3-py2.py3-none-any.whl (100 kB) 2022-09-29T10:23:21.4661243Z Collecting MarkupSafe>=2.0 2022-09-29T10:23:21.4691261Z Using cached MarkupSafe-2.1.1-cp310-cp310-win_amd64.whl (17 kB) 2022-09-29T10:23:21.5747981Z Collecting wcwidth 2022-09-29T10:23:21.5776672Z Using cached wcwidth-0.2.5-py2.py3-none-any.whl (30 kB) 2022-09-29T10:23:21.7510230Z Collecting certifi>=2017.4.17 2022-09-29T10:23:21.7539140Z Using cached certifi-2022.9.24-py3-none-any.whl (161 kB) 2022-09-29T10:23:21.7938333Z Collecting charset-normalizer<3,>=2 2022-09-29T10:23:21.7965848Z Using cached charset_normalizer-2.1.1-py3-none-any.whl (39 kB) 2022-09-29T10:23:21.8320140Z Collecting idna<4,>=2.5 2022-09-29T10:23:21.8346498Z Using cached idna-3.4-py3-none-any.whl (61 kB) 2022-09-29T10:23:21.8851986Z Collecting urllib3<1.27,>=1.21.1 2022-09-29T10:23:21.8881277Z Using cached urllib3-1.26.12-py2.py3-none-any.whl (140 kB) 2022-09-29T10:23:22.1860786Z Collecting contextlib2>=0.5.5 2022-09-29T10:23:22.1886256Z Using cached contextlib2-21.6.0-py2.py3-none-any.whl (13 kB) 2022-09-29T10:23:22.2907785Z Collecting pure-eval 2022-09-29T10:23:22.2935841Z Using cached pure_eval-0.2.2-py3-none-any.whl (11 kB) 2022-09-29T10:23:22.3253145Z Collecting executing 2022-09-29T10:23:22.3277897Z Using cached executing-1.1.0-py2.py3-none-any.whl (22 kB) 2022-09-29T10:23:22.3509516Z Collecting asttokens 2022-09-29T10:23:22.3534102Z Using cached asttokens-2.0.8-py2.py3-none-any.whl (23 kB) 2022-09-29T10:23:22.5509929Z Collecting cffi>=1.12 2022-09-29T10:23:22.5542638Z Using cached cffi-1.15.1-cp310-cp310-win_amd64.whl (179 kB) 2022-09-29T10:23:22.6649711Z Collecting cachetools<6.0,>=2.0.0 2022-09-29T10:23:22.6675841Z Using cached cachetools-5.2.0-py3-none-any.whl (9.3 kB) 2022-09-29T10:23:22.7147008Z Collecting pyasn1-modules>=0.2.1 2022-09-29T10:23:22.7173051Z Using cached pyasn1_modules-0.2.8-py2.py3-none-any.whl (155 kB) 2022-09-29T10:23:22.8142936Z Collecting entrypoints 2022-09-29T10:23:22.8166846Z Using cached entrypoints-0.4-py3-none-any.whl (5.3 kB) 2022-09-29T10:23:22.8569935Z Collecting jupyter-core>=4.9.2 2022-09-29T10:23:22.8595256Z Using cached jupyter_core-4.11.1-py3-none-any.whl (88 kB) 2022-09-29T10:23:22.9363087Z Collecting PyJWT[crypto]<3,>=1.0.0 2022-09-29T10:23:22.9388004Z Using cached PyJWT-2.5.0-py3-none-any.whl (20 kB) 2022-09-29T10:23:23.0176584Z Collecting portalocker<3,>=1.6 2022-09-29T10:23:23.0201895Z Using cached portalocker-2.5.1-py2.py3-none-any.whl (15 kB) 2022-09-29T10:23:23.2523378Z Collecting pycparser 2022-09-29T10:23:23.2550709Z Using cached pycparser-2.21-py2.py3-none-any.whl (118 kB) 2022-09-29T10:23:23.3088679Z Collecting pywin32>=1.0 2022-09-29T10:23:23.3359931Z Using cached pywin32-304-cp310-cp310-win_amd64.whl (12.1 MB) 2022-09-29T10:23:23.5093353Z Collecting types-cryptography>=3.3.21 2022-09-29T10:23:23.5117903Z Using cached types_cryptography-3.3.23-py3-none-any.whl (30 kB) 2022-09-29T10:23:23.6562567Z Building wheels for collected packages: sphinx, qcodes 2022-09-29T10:23:23.6906385Z Building wheel for sphinx (setup.py): started 2022-09-29T10:23:28.1873865Z Building wheel for sphinx (setup.py): finished with status 'done' 2022-09-29T10:23:28.1988429Z Created wheel for sphinx: filename=Sphinx-5.0.3.dev20220929-py3-none-any.whl size=3144387 sha256=49333313219cd3e0b89e6d145aedfbe9360cde1d63c85d3d1e72546979f0639a 2022-09-29T10:23:28.1990527Z Stored in directory: C:\Users\runneradmin\AppData\Local\Temp\pip-ephem-wheel-cache-7aa7jei3\wheels\74\ab\7f\8106ef9b868d783dfbb8c4f1f07f8ebee5b166b1e284f4a2cf 2022-09-29T10:23:28.2086905Z Building wheel for qcodes (pyproject.toml): started 2022-09-29T10:23:30.2246281Z Building wheel for qcodes (pyproject.toml): finished with status 'done' 2022-09-29T10:23:30.2313305Z Created wheel for qcodes: filename=qcodes-0.0-py3-none-any.whl size=1300816 sha256=a666de73b3f8a0b9c75d2e54c16f5fe0af540928d4d2b2d24fd087e51203e3d5 2022-09-29T10:23:30.2315536Z Stored in directory: C:\Users\runneradmin\AppData\Local\Temp\pip-ephem-wheel-cache-7aa7jei3\wheels\4b\50\2a\94b90ae4f96286f93dd78df083a2db759ddc1d13c997321baa 2022-09-29T10:23:30.2398440Z Successfully built sphinx qcodes 2022-09-29T10:23:31.0673045Z Installing collected packages: wcwidth, types-urllib3, types-tqdm, types-tabulate, types-setuptools, types-pytz, types-jsonschema, types-cryptography, stringparser, sortedcontainers, snowballstemmer, pywin32, pytz, PyQt5-Qt5, pyasn1, pure-eval, pickleshare, opencensus-context, mypy-extensions, lxml-stubs, iniconfig, executing, backcall, alabaster, wrapt, widgetsnbextension, websockets, urllib3, typing-extensions, types-requests, traitlets, tornado, tomli, tabulate, sphinxcontrib-serializinghtml, sphinxcontrib-qthelp, sphinxcontrib-jsmath, sphinxcontrib-htmlhelp, sphinxcontrib-devhelp, sphinxcontrib-applehelp, slack-sdk, six, ruamel.yaml.clib, rsa, pyzmq, PyYAML, pyrsistent, PyQt5-sip, pyparsing, PyJWT, pygments, pycparser, pyasn1-modules, py, psutil, protobuf, prompt-toolkit, portalocker, pluggy, pillow, parso, pandas-stubs, ordered-set, numpy, nest-asyncio, MarkupSafe, lxml, kiwisolver, jupyterlab-widgets, imagesize, idna, future, fonttools, execnet, exceptiongroup, entrypoints, docutils, decorator, debugpy, cycler, coverage, contextlib2, colorama, charset-normalizer, certifi, cachetools, babel, attrs, uncertainties, tqdm, schema, ruamel.yaml, requests, pyvisa, python-dateutil, pyqtgraph, PyQt5, packaging, mypy, matplotlib-inline, jupyter-core, jsonschema, Jinja2, jedi, hypothesis, h5py, googleapis-common-protos, google-auth, deepdiff, contourpy, cffi, asttokens, versioningit, stack-data, sphinx, PyVisa-sim, pytest, pandas, matplotlib, jupyter-client, h5netcdf, google-api-core, cryptography, azure-core, xarray, pytest-rerunfailures, pytest-mock, pytest-forked, pytest-cov, opencensus, ipython, broadbean, pytest-xdist, msal, ipykernel, msal-extensions, ipywidgets, azure-identity, opencensus-ext-azure, qcodes 2022-09-29T10:25:09.5379507Z Successfully installed Jinja2-3.1.2 MarkupSafe-2.1.1 PyJWT-2.5.0 PyQt5-5.15.7 PyQt5-Qt5-5.15.2 PyQt5-sip-12.11.0 PyVisa-sim-0.5.1 PyYAML-6.0 alabaster-0.7.12 asttokens-2.0.8 attrs-22.1.0 azure-core-1.25.1 azure-identity-1.11.0 babel-2.10.3 backcall-0.2.0 broadbean-0.11.0 cachetools-5.2.0 certifi-2022.9.24 cffi-1.15.1 charset-normalizer-2.1.1 colorama-0.4.5 contextlib2-21.6.0 contourpy-1.0.5 coverage-6.4.4 cryptography-38.0.1 cycler-0.11.0 debugpy-1.6.3 decorator-5.1.1 deepdiff-5.8.1 docutils-0.17.1 entrypoints-0.4 exceptiongroup-1.0.0rc9 execnet-1.9.0 executing-1.1.0 fonttools-4.37.3 future-0.18.2 google-api-core-2.10.1 google-auth-2.12.0 googleapis-common-protos-1.56.4 h5netcdf-0.15.0 h5py-3.7.0 hypothesis-6.54.6 idna-3.4 imagesize-1.4.1 iniconfig-1.1.1 ipykernel-6.16.0 ipython-8.5.0 ipywidgets-8.0.2 jedi-0.18.1 jsonschema-4.16.0 jupyter-client-7.3.5 jupyter-core-4.11.1 jupyterlab-widgets-3.0.3 kiwisolver-1.4.4 lxml-4.9.1 lxml-stubs-0.4.0 matplotlib-3.6.0 matplotlib-inline-0.1.6 msal-1.19.0 msal-extensions-1.0.0 mypy-0.981 mypy-extensions-0.4.3 nest-asyncio-1.5.5 numpy-1.23.3 opencensus-0.11.0 opencensus-context-0.1.3 opencensus-ext-azure-1.1.7 ordered-set-4.1.0 packaging-21.3 pandas-1.5.0 pandas-stubs-1.5.0.220926 parso-0.8.3 pickleshare-0.7.5 pillow-9.2.0 pluggy-1.0.0 portalocker-2.5.1 prompt-toolkit-3.0.31 protobuf-4.21.6 psutil-5.9.2 pure-eval-0.2.2 py-1.11.0 pyasn1-0.4.8 pyasn1-modules-0.2.8 pycparser-2.21 pygments-2.13.0 pyparsing-3.0.9 pyqtgraph-0.13.1 pyrsistent-0.18.1 pytest-7.1.3 pytest-cov-4.0.0 pytest-forked-1.4.0 pytest-mock-3.9.0 pytest-rerunfailures-10.2 pytest-xdist-2.5.0 python-dateutil-2.8.2 pytz-2022.2.1 pyvisa-1.12.0 pywin32-304 pyzmq-24.0.1 qcodes-0.0 requests-2.28.1 rsa-4.9 ruamel.yaml-0.17.21 ruamel.yaml.clib-0.2.6 schema-0.7.5 six-1.16.0 slack-sdk-3.18.3 snowballstemmer-2.2.0 sortedcontainers-2.4.0 sphinx-5.0.3.dev20220929 sphinxcontrib-applehelp-1.0.2 sphinxcontrib-devhelp-1.0.2 sphinxcontrib-htmlhelp-2.0.0 sphinxcontrib-jsmath-1.0.1 sphinxcontrib-qthelp-1.0.3 sphinxcontrib-serializinghtml-1.1.5 stack-data-0.5.1 stringparser-0.5 tabulate-0.8.10 tomli-2.0.1 tornado-6.2 tqdm-4.64.1 traitlets-5.4.0 types-cryptography-3.3.23 types-jsonschema-4.16.1 types-pytz-2022.2.1.0 types-requests-2.28.11 types-setuptools-65.3.0 types-tabulate-0.8.11 types-tqdm-4.64.7 types-urllib3-1.26.25 typing-extensions-4.3.0 uncertainties-3.1.7 urllib3-1.26.12 versioningit-2.0.1 wcwidth-0.2.5 websockets-10.3 widgetsnbextension-4.0.3 wrapt-1.14.1 xarray-2022.6.0 2022-09-29T10:25:12.3991834Z ##[group]Run mypy -p qcodes 2022-09-29T10:25:12.3992320Z mypy -p qcodes 2022-09-29T10:25:12.4032199Z shell: C:\Program Files\PowerShell\7\pwsh.EXE -command ". '{0}'" 2022-09-29T10:25:12.4032513Z env: 2022-09-29T10:25:12.4032725Z DISPLAY: :99.0 2022-09-29T10:25:12.4032949Z OS: windows-latest 2022-09-29T10:25:12.4033170Z PYTHON: 3.10 2022-09-29T10:25:12.4033472Z pythonLocation: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:25:12.4033844Z PKG_CONFIG_PATH: C:\hostedtoolcache\windows\Python\3.10.7\x64/lib/pkgconfig 2022-09-29T10:25:12.4034225Z Python_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:25:12.4034587Z Python2_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:25:12.4034941Z Python3_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:25:12.4035219Z ##[endgroup] 2022-09-29T10:26:38.4593526Z Success: no issues found in 609 source files 2022-09-29T10:26:38.7193748Z ##[group]Run pytest -m "not serial" --cov=qcodes --cov-report xml --hypothesis-profile ci qcodes 2022-09-29T10:26:38.7194400Z pytest -m "not serial" --cov=qcodes --cov-report xml --hypothesis-profile ci qcodes 2022-09-29T10:26:38.7235215Z shell: C:\Program Files\PowerShell\7\pwsh.EXE -command ". '{0}'" 2022-09-29T10:26:38.7235588Z env: 2022-09-29T10:26:38.7235801Z DISPLAY: :99.0 2022-09-29T10:26:38.7236072Z OS: windows-latest 2022-09-29T10:26:38.7236341Z PYTHON: 3.10 2022-09-29T10:26:38.7236704Z pythonLocation: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:26:38.7391542Z PKG_CONFIG_PATH: C:\hostedtoolcache\windows\Python\3.10.7\x64/lib/pkgconfig 2022-09-29T10:26:38.7392042Z Python_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:26:38.7392378Z Python2_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:26:38.7392725Z Python3_ROOT_DIR: C:\hostedtoolcache\windows\Python\3.10.7\x64 2022-09-29T10:26:38.7397734Z ##[endgroup] 2022-09-29T10:28:49.0827976Z ============================= test session starts ============================= 2022-09-29T10:28:49.1882588Z platform win32 -- Python 3.10.7, pytest-7.1.3, pluggy-1.0.0 2022-09-29T10:28:49.2851949Z rootdir: D:\a\Qcodes\Qcodes, configfile: pyproject.toml 2022-09-29T10:28:49.3950398Z plugins: hypothesis-6.54.6, cov-4.0.0, forked-1.4.0, mock-3.9.0, rerunfailures-10.2, xdist-2.5.0 2022-09-29T10:28:49.4884797Z gw0 I / gw1 I 2022-09-29T10:28:49.5982169Z gw0 [2911] / gw1 [2911] 2022-09-29T10:28:49.6039292Z 2022-09-29T10:28:49.9084222Z .........................................x...........x..x.x............. [ 2%] 2022-09-29T10:29:01.2002958Z ........................................................................ [ 4%] 2022-09-29T10:29:22.4680954Z ........................................................................ [ 7%] 2022-09-29T10:29:25.4592245Z ........................................................................ [ 9%] 2022-09-29T10:30:03.3129151Z ........................................................................ [ 12%] 2022-09-29T10:31:10.1447844Z ..........................X............................................. [ 14%] 2022-09-29T10:32:00.9535162Z ..........x............................................................. [ 17%] 2022-09-29T10:33:20.2031631Z ...............................................................X........ [ 19%] 2022-09-29T10:33:51.9817100Z ........................................................................ [ 22%] 2022-09-29T10:35:08.4481261Z ........................................................................ [ 24%] 2022-09-29T10:38:45.2264296Z ........................................................................ [ 27%] 2022-09-29T10:39:47.3638087Z ........................................................................ [ 29%] 2022-09-29T10:40:21.9468811Z ........................................................................ [ 32%] 2022-09-29T10:41:24.7265160Z ...................................................F.................... [ 34%] 2022-09-29T10:42:53.9092334Z ........................................................................ [ 37%] 2022-09-29T10:44:11.3881819Z ........................................................................ [ 39%] 2022-09-29T10:44:22.5166264Z ..sssss................................................................. [ 42%] 2022-09-29T10:44:28.6905726Z ........................................................................ [ 44%] 2022-09-29T10:44:32.0514383Z ....................................................x................... [ 46%] 2022-09-29T10:44:40.0029689Z ........................................................................ [ 49%] 2022-09-29T10:44:43.3125375Z .................X..ss...ssssssssssss................................... [ 51%] 2022-09-29T10:44:43.5903195Z .........................sssssssssssssssssssssssssssssssssssssssssssssss [ 54%] 2022-09-29T10:44:43.8927179Z sssssssssssssssss.sssss...s...sssssssssssssssssssssss.ssss.s.s.sssss.sss [ 56%] 2022-09-29T10:44:44.1312256Z ssss.ssssss.ssssss.sssss.sss.ssssss.sssssssssssssssssssssssss.sssssss.ss [ 59%] 2022-09-29T10:44:45.5872990Z sssssss.ssssss.ssssssssssssssssssssssssssssss........................... [ 61%] 2022-09-29T10:44:46.5708469Z ........................................................................ [ 64%] 2022-09-29T10:44:50.3977052Z ........................................................................ [ 66%] 2022-09-29T10:44:52.4393246Z ........................................................................ [ 69%] 2022-09-29T10:44:53.9495899Z ........................................................................ [ 71%] 2022-09-29T10:44:54.3292909Z ........................................................................ [ 74%] 2022-09-29T10:44:56.7547647Z ........................................................................ [ 76%] 2022-09-29T10:45:00.8358465Z ........................................................................ [ 79%] 2022-09-29T10:45:01.5019579Z ........................................................................ [ 81%] 2022-09-29T10:45:01.8501117Z ........................................................................ [ 84%] 2022-09-29T10:45:02.2439001Z ........................................................................ [ 86%] 2022-09-29T10:45:02.4879800Z ........................................................................ [ 89%] 2022-09-29T10:45:02.8789873Z ........................................................................ [ 91%] 2022-09-29T10:45:03.1970645Z ........................................................................ [ 93%] 2022-09-29T10:45:03.5944561Z ........................................................................ [ 96%] 2022-09-29T10:45:04.7591845Z ........................................................................ [ 98%] 2022-09-29T10:45:16.0882130Z Exception in thread Thread-981: 2022-09-29T10:45:16.0892903Z Traceback (most recent call last): 2022-09-29T10:45:16.0900791Z File "C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\threading.py", line 1016, in _bootstrap_inner 2022-09-29T10:45:16.0947592Z Exception in thread Thread-980: 2022-09-29T10:45:16.0949398Z Traceback (most recent call last): 2022-09-29T10:45:16.0955151Z File "C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\threading.py", line 1016, in _bootstrap_inner 2022-09-29T10:45:16.2268876Z self.run() 2022-09-29T10:45:16.2777912Z self.run() 2022-09-29T10:45:16.2782468Z File "C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\site-packages\pyqtgraph\multiprocess\processes.py", line 534, in run 2022-09-29T10:45:16.2816050Z File "C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\site-packages\pyqtgraph\multiprocess\processes.py", line 534, in run 2022-09-29T10:45:16.2817248Z self.output.write(line.decode('utf8')) 2022-09-29T10:45:16.2838385Z self.output.write(line.decode('utf8')) 2022-09-29T10:45:16.2841641Z ValueError: I/O operation on closed file. 2022-09-29T10:45:16.2844750Z ValueError: I/O operation on closed file. 2022-09-29T10:45:17.4944154Z ............................... [100%] 2022-09-29T10:45:17.4945545Z ================================== FAILURES =================================== 2022-09-29T10:45:17.4946134Z ___________________________ test_datasaver_scalars ____________________________ 2022-09-29T10:45:17.4947077Z [gw0] win32 -- Python 3.10.7 C:\hostedtoolcache\windows\Python\3.10.7\x64\python.exe 2022-09-29T10:45:17.4947471Z 2022-09-29T10:45:17.4947824Z self = 2022-09-29T10:45:17.4948362Z data = ConjectureData(INTERESTING, 461 bytes, frozen) 2022-09-29T10:45:17.4948681Z 2022-09-29T10:45:17.4948945Z def _execute_once_for_engine(self, data): 2022-09-29T10:45:17.4949433Z """Wrapper around ``execute_once`` that intercepts test failure 2022-09-29T10:45:17.4950706Z exceptions and single-test control exceptions, and turns them into 2022-09-29T10:45:17.4951289Z appropriate method calls to `data` instead. 2022-09-29T10:45:17.4951585Z 2022-09-29T10:45:17.4951884Z This allows the engine to assume that any exception other than 2022-09-29T10:45:17.4952231Z ``StopTest`` must be a fatal error, and should stop the entire engine. 2022-09-29T10:45:17.4952516Z """ 2022-09-29T10:45:17.4952715Z try: 2022-09-29T10:45:17.4952932Z trace = frozenset() 2022-09-29T10:45:17.4953177Z if ( 2022-09-29T10:45:17.4953433Z self.failed_normally 2022-09-29T10:45:17.4953712Z and not self.failed_due_to_deadline 2022-09-29T10:45:17.4954056Z and Phase.shrink in self.settings.phases 2022-09-29T10:45:17.4954434Z and Phase.explain in self.settings.phases 2022-09-29T10:45:17.4954768Z and sys.gettrace() is None 2022-09-29T10:45:17.4955034Z and not PYPY 2022-09-29T10:45:17.4955273Z ): # pragma: no cover 2022-09-29T10:45:17.4955910Z # This is in fact covered by our *non-coverage* tests, but due to the 2022-09-29T10:45:17.4956331Z # settrace() contention *not* by our coverage tests. Ah well. 2022-09-29T10:45:17.4956670Z tracer = Tracer() 2022-09-29T10:45:17.4956930Z try: 2022-09-29T10:45:17.4957216Z sys.settrace(tracer.trace) 2022-09-29T10:45:17.4957508Z result = self.execute_once(data) 2022-09-29T10:45:17.4957851Z if data.status == Status.VALID: 2022-09-29T10:45:17.4958248Z self.explain_traces[None].add(frozenset(tracer.branches)) 2022-09-29T10:45:17.4958635Z finally: 2022-09-29T10:45:17.4958910Z sys.settrace(None) 2022-09-29T10:45:17.4959196Z trace = frozenset(tracer.branches) 2022-09-29T10:45:17.4961041Z else: 2022-09-29T10:45:17.4961546Z > result = self.execute_once(data) 2022-09-29T10:45:17.4961759Z 2022-09-29T10:45:17.4963369Z C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\site-packages\hypothesis\core.py:753: 2022-09-29T10:45:17.4963886Z _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 2022-09-29T10:45:17.4964073Z 2022-09-29T10:45:17.4964331Z self = 2022-09-29T10:45:17.4964819Z data = ConjectureData(INTERESTING, 461 bytes, frozen), print_example = False 2022-09-29T10:45:17.4965160Z is_final = False, expected_failure = None 2022-09-29T10:45:17.4965342Z 2022-09-29T10:45:17.4965457Z def execute_once( 2022-09-29T10:45:17.4965808Z self, data, print_example=False, is_final=False, expected_failure=None 2022-09-29T10:45:17.4966102Z ): 2022-09-29T10:45:17.4966426Z """Run the test function once, using ``data`` as input. 2022-09-29T10:45:17.4966675Z 2022-09-29T10:45:17.4967006Z If the test raises an exception, it will propagate through to the 2022-09-29T10:45:17.4967425Z caller of this method. Depending on its type, this could represent 2022-09-29T10:45:17.4968003Z an ordinary test failure, or a fatal error, or a control exception. 2022-09-29T10:45:17.4968318Z 2022-09-29T10:45:17.4968634Z If this method returns normally, the test might have passed, or 2022-09-29T10:45:17.4969000Z it might have placed ``data`` in an unsuccessful state and then 2022-09-29T10:45:17.4969383Z swallowed the corresponding control exception. 2022-09-29T10:45:17.4969681Z """ 2022-09-29T10:45:17.4969906Z 2022-09-29T10:45:17.4970163Z self.ever_executed = True 2022-09-29T10:45:17.4970415Z data.is_find = self.is_find 2022-09-29T10:45:17.4970675Z 2022-09-29T10:45:17.4970918Z text_repr = None 2022-09-29T10:45:17.4971224Z if self.settings.deadline is None: 2022-09-29T10:45:17.4971524Z test = self.test 2022-09-29T10:45:17.4971805Z else: 2022-09-29T10:45:17.4972025Z 2022-09-29T10:45:17.4972288Z @proxies(self.test) 2022-09-29T10:45:17.4972573Z def test(*args, **kwargs): 2022-09-29T10:45:17.4972839Z self.__test_runtime = None 2022-09-29T10:45:17.4973161Z initial_draws = len(data.draw_times) 2022-09-29T10:45:17.4973455Z start = time.perf_counter() 2022-09-29T10:45:17.4973766Z result = self.test(*args, **kwargs) 2022-09-29T10:45:17.4974071Z finish = time.perf_counter() 2022-09-29T10:45:17.4974388Z internal_draw_time = sum(data.draw_times[initial_draws:]) 2022-09-29T10:45:17.4974728Z runtime = datetime.timedelta( 2022-09-29T10:45:17.4975234Z seconds=finish - start - internal_draw_time 2022-09-29T10:45:17.4975512Z ) 2022-09-29T10:45:17.4975761Z self.__test_runtime = runtime 2022-09-29T10:45:17.4976054Z current_deadline = self.settings.deadline 2022-09-29T10:45:17.4976352Z if not is_final: 2022-09-29T10:45:17.4976682Z current_deadline = (current_deadline // 4) * 5 2022-09-29T10:45:17.4977039Z if runtime >= current_deadline: 2022-09-29T10:45:17.4977422Z raise DeadlineExceeded(runtime, self.settings.deadline) 2022-09-29T10:45:17.4977776Z return result 2022-09-29T10:45:17.4977991Z 2022-09-29T10:45:17.4978229Z def run(data): 2022-09-29T10:45:17.4978540Z # Set up dynamic context needed by a single test run. 2022-09-29T10:45:17.4978893Z with local_settings(self.settings): 2022-09-29T10:45:17.4979214Z with deterministic_PRNG(): 2022-09-29T10:45:17.4979517Z with BuildContext(data, is_final=is_final): 2022-09-29T10:45:17.4979806Z 2022-09-29T10:45:17.4980108Z # Generate all arguments to the test function. 2022-09-29T10:45:17.4980493Z args, kwargs = data.draw(self.search_strategy) 2022-09-29T10:45:17.4980836Z if expected_failure is not None: 2022-09-29T10:45:17.4981139Z nonlocal text_repr 2022-09-29T10:45:17.4981430Z text_repr = repr_call(test, args, kwargs) 2022-09-29T10:45:17.4981716Z 2022-09-29T10:45:17.4982033Z if print_example or current_verbosity() >= Verbosity.verbose: 2022-09-29T10:45:17.4982393Z output = StringIO() 2022-09-29T10:45:17.4982657Z 2022-09-29T10:45:17.4982933Z printer = RepresentationPrinter(output) 2022-09-29T10:45:17.4983272Z if print_example: 2022-09-29T10:45:17.4983608Z printer.text("Falsifying example:") 2022-09-29T10:45:17.4983927Z else: 2022-09-29T10:45:17.4984242Z printer.text("Trying example:") 2022-09-29T10:45:17.4984522Z 2022-09-29T10:45:17.4984853Z if self.print_given_args: 2022-09-29T10:45:17.4985171Z printer.text(" ") 2022-09-29T10:45:17.4985485Z printer.text(test.__name__) 2022-09-29T10:45:17.4985844Z with printer.group(indent=4, open="(", close=""): 2022-09-29T10:45:17.4986199Z printer.break_() 2022-09-29T10:45:17.4986481Z for v in args: 2022-09-29T10:45:17.4986762Z printer.pretty(v) 2022-09-29T10:45:17.4987154Z # We add a comma unconditionally because 2022-09-29T10:45:17.4987539Z # generated arguments will always be kwargs, 2022-09-29T10:45:17.4987916Z # so there will always be more to come. 2022-09-29T10:45:17.4988324Z printer.text(",") 2022-09-29T10:45:17.4988640Z printer.breakable() 2022-09-29T10:45:17.4988861Z 2022-09-29T10:45:17.4989165Z for i, (k, v) in enumerate(kwargs.items()): 2022-09-29T10:45:17.4989507Z printer.text(k) 2022-09-29T10:45:17.4989823Z printer.text("=") 2022-09-29T10:45:17.4990143Z printer.pretty(v) 2022-09-29T10:45:17.4990427Z printer.text(",") 2022-09-29T10:45:17.4990735Z if i + 1 < len(kwargs): 2022-09-29T10:45:17.4991039Z printer.breakable() 2022-09-29T10:45:17.4991360Z printer.break_() 2022-09-29T10:45:17.4991669Z printer.text(")") 2022-09-29T10:45:17.4991989Z printer.flush() 2022-09-29T10:45:17.4992265Z report(output.getvalue()) 2022-09-29T10:45:17.4992604Z return test(*args, **kwargs) 2022-09-29T10:45:17.4992872Z 2022-09-29T10:45:17.4993139Z # Run the test function once, via the executor hook. 2022-09-29T10:45:17.4993516Z # In most cases this will delegate straight to `run(data)`. 2022-09-29T10:45:17.4993818Z > result = self.test_runner(data, run) 2022-09-29T10:45:17.4994000Z 2022-09-29T10:45:17.4994364Z C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\site-packages\hypothesis\core.py:692: 2022-09-29T10:45:17.4994754Z _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 2022-09-29T10:45:17.4995307Z 2022-09-29T10:45:17.4995473Z data = ConjectureData(INTERESTING, 461 bytes, frozen) 2022-09-29T10:45:17.4995944Z function = .run at 0x0000020066DD57E0> 2022-09-29T10:45:17.4996233Z 2022-09-29T10:45:17.4996388Z def default_new_style_executor(data, function): 2022-09-29T10:45:17.4996690Z > return function(data) 2022-09-29T10:45:17.4996864Z 2022-09-29T10:45:17.4997220Z C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\site-packages\hypothesis\executors.py:47: 2022-09-29T10:45:17.4997607Z _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 2022-09-29T10:45:17.4997764Z 2022-09-29T10:45:17.4997943Z data = ConjectureData(INTERESTING, 461 bytes, frozen) 2022-09-29T10:45:17.4998152Z 2022-09-29T10:45:17.4998266Z def run(data): 2022-09-29T10:45:17.4998584Z # Set up dynamic context needed by a single test run. 2022-09-29T10:45:17.4998914Z with local_settings(self.settings): 2022-09-29T10:45:17.4999239Z with deterministic_PRNG(): 2022-09-29T10:45:17.4999537Z with BuildContext(data, is_final=is_final): 2022-09-29T10:45:17.4999806Z 2022-09-29T10:45:17.5000128Z # Generate all arguments to the test function. 2022-09-29T10:45:17.5000607Z args, kwargs = data.draw(self.search_strategy) 2022-09-29T10:45:17.5000963Z if expected_failure is not None: 2022-09-29T10:45:17.5001281Z nonlocal text_repr 2022-09-29T10:45:17.5001571Z text_repr = repr_call(test, args, kwargs) 2022-09-29T10:45:17.5001863Z 2022-09-29T10:45:17.5002189Z if print_example or current_verbosity() >= Verbosity.verbose: 2022-09-29T10:45:17.5002542Z output = StringIO() 2022-09-29T10:45:17.5002807Z 2022-09-29T10:45:17.5003076Z printer = RepresentationPrinter(output) 2022-09-29T10:45:17.5003409Z if print_example: 2022-09-29T10:45:17.5003741Z printer.text("Falsifying example:") 2022-09-29T10:45:17.5004026Z else: 2022-09-29T10:45:17.5004923Z printer.text("Trying example:") 2022-09-29T10:45:17.5005198Z 2022-09-29T10:45:17.5005482Z if self.print_given_args: 2022-09-29T10:45:17.5005805Z printer.text(" ") 2022-09-29T10:45:17.5006131Z printer.text(test.__name__) 2022-09-29T10:45:17.5006477Z with printer.group(indent=4, open="(", close=""): 2022-09-29T10:45:17.5006837Z printer.break_() 2022-09-29T10:45:17.5007100Z for v in args: 2022-09-29T10:45:17.5007413Z printer.pretty(v) 2022-09-29T10:45:17.5007766Z # We add a comma unconditionally because 2022-09-29T10:45:17.5008156Z # generated arguments will always be kwargs, 2022-09-29T10:45:17.5008533Z # so there will always be more to come. 2022-09-29T10:45:17.5008882Z printer.text(",") 2022-09-29T10:45:17.5009146Z printer.breakable() 2022-09-29T10:45:17.5009423Z 2022-09-29T10:45:17.5009728Z for i, (k, v) in enumerate(kwargs.items()): 2022-09-29T10:45:17.5010056Z printer.text(k) 2022-09-29T10:45:17.5010360Z printer.text("=") 2022-09-29T10:45:17.5010640Z printer.pretty(v) 2022-09-29T10:45:17.5010943Z printer.text(",") 2022-09-29T10:45:17.5011265Z if i + 1 < len(kwargs): 2022-09-29T10:45:17.5011583Z printer.breakable() 2022-09-29T10:45:17.5011897Z printer.break_() 2022-09-29T10:45:17.5012204Z printer.text(")") 2022-09-29T10:45:17.5012515Z printer.flush() 2022-09-29T10:45:17.5012831Z report(output.getvalue()) 2022-09-29T10:45:17.5013160Z > return test(*args, **kwargs) 2022-09-29T10:45:17.5013341Z 2022-09-29T10:45:17.5013732Z C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\site-packages\hypothesis\core.py:688: 2022-09-29T10:45:17.5014151Z _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 2022-09-29T10:45:17.5014337Z 2022-09-29T10:45:17.5014906Z experiment = test-experiment#test-sample#1@C:\Users\runneradmin\AppData\Local\Temp\pytest-of-runneradmin\pytest-0\popen-gw0\test_da...s-22-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5015530Z 23-results-23-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5015885Z 24-results-24-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5016240Z DAC = , DMM = 2022-09-29T10:45:17.5016606Z set_values = [0.0, 0.0, 0.0, 0.0, 0.0, 0.0, ...] 2022-09-29T10:45:17.5016939Z get_values = [0.0, 0.0, 0.0, 0.0, 0.0, 0.0, ...], breakpoint = 1 2022-09-29T10:45:17.5017359Z write_period = 0.1 2022-09-29T10:45:17.5017518Z 2022-09-29T10:45:17.5017673Z @settings(max_examples=5, deadline=None, 2022-09-29T10:45:17.5018023Z suppress_health_check=(HealthCheck.function_scoped_fixture,)) 2022-09-29T10:45:17.5018444Z @given(breakpoint=hst.integers(min_value=1, max_value=19), 2022-09-29T10:45:17.5018831Z write_period=hst.floats(min_value=0.1, max_value=1.5), 2022-09-29T10:45:17.5019239Z set_values=hst.lists(elements=hst.floats(), min_size=20, max_size=20), 2022-09-29T10:45:17.5019654Z get_values=hst.lists(elements=hst.floats(), min_size=20, max_size=20)) 2022-09-29T10:45:17.5020161Z @pytest.mark.usefixtures('set_default_station_to_none') 2022-09-29T10:45:17.5020544Z def test_datasaver_scalars(experiment, DAC, DMM, set_values, get_values, 2022-09-29T10:45:17.5020936Z breakpoint, write_period): 2022-09-29T10:45:17.5021287Z no_of_runs = len(experiment) 2022-09-29T10:45:17.5021559Z 2022-09-29T10:45:17.5021822Z station = qc.Station(DAC, DMM) 2022-09-29T10:45:17.5022051Z 2022-09-29T10:45:17.5022329Z meas = Measurement(station=station) 2022-09-29T10:45:17.5022625Z meas.write_period = write_period 2022-09-29T10:45:17.5022870Z 2022-09-29T10:45:17.5023141Z assert meas.write_period == write_period 2022-09-29T10:45:17.5023377Z 2022-09-29T10:45:17.5023624Z meas.register_parameter(DAC.ch1) 2022-09-29T10:45:17.5024000Z meas.register_parameter(DMM.v1, setpoints=(DAC.ch1,)) 2022-09-29T10:45:17.5024291Z 2022-09-29T10:45:17.5024504Z with meas.run() as datasaver: 2022-09-29T10:45:17.5024780Z for set_v, get_v in zip(set_values[:breakpoint], 2022-09-29T10:45:17.5025111Z get_values[:breakpoint]): 2022-09-29T10:45:17.5025467Z datasaver.add_result((DAC.ch1, set_v), (DMM.v1, get_v)) 2022-09-29T10:45:17.5025784Z 2022-09-29T10:45:17.5026095Z assert datasaver._dataset.number_of_results == 0 2022-09-29T10:45:17.5026437Z sleep(write_period * 1.1) 2022-09-29T10:45:17.5026756Z datasaver.add_result((DAC.ch1, set_values[breakpoint]), 2022-09-29T10:45:17.5027133Z (DMM.v1, get_values[breakpoint])) 2022-09-29T10:45:17.5027510Z > assert datasaver.points_written == breakpoint + 1 2022-09-29T10:45:17.5027838Z E assert 0 == (1 + 1) 2022-09-29T10:45:17.5028232Z E + where 0 = .points_written 2022-09-29T10:45:17.5028538Z 2022-09-29T10:45:17.5028792Z qcodes\tests\dataset\measurement\test_measurement_context_manager.py:626: AssertionError 2022-09-29T10:45:17.5029069Z 2022-09-29T10:45:17.5029257Z The above exception was the direct cause of the following exception: 2022-09-29T10:45:17.5029444Z 2022-09-29T10:45:17.5029993Z experiment = test-experiment#test-sample#1@C:\Users\runneradmin\AppData\Local\Temp\pytest-of-runneradmin\pytest-0\popen-gw0\test_da...s-22-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5030599Z 23-results-23-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5030976Z 24-results-24-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5031358Z DAC = , DMM = 2022-09-29T10:45:17.5031596Z 2022-09-29T10:45:17.5031750Z @settings(max_examples=5, deadline=None, 2022-09-29T10:45:17.5032117Z > suppress_health_check=(HealthCheck.function_scoped_fixture,)) 2022-09-29T10:45:17.5032358Z 2022-09-29T10:45:17.5032585Z qcodes\tests\dataset\measurement\test_measurement_context_manager.py:597: 2022-09-29T10:45:17.5032940Z _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 2022-09-29T10:45:17.5033119Z 2022-09-29T10:45:17.5033380Z self = 2022-09-29T10:45:17.5033837Z data = ConjectureData(VALID, 461 bytes, frozen), print_example = True 2022-09-29T10:45:17.5034241Z is_final = True 2022-09-29T10:45:17.5035077Z expected_failure = (AssertionError('assert 0 == (1 + 1)\n + where 0 = .points_written\n\nqcodes\\tests\\dataset\\measurement\\test_measurement_context_manager.py:626: AssertionError\n') 2022-09-29T10:45:17.5035555Z 2022-09-29T10:45:17.5035671Z def execute_once( 2022-09-29T10:45:17.5036035Z self, data, print_example=False, is_final=False, expected_failure=None 2022-09-29T10:45:17.5036363Z ): 2022-09-29T10:45:17.5036626Z """Run the test function once, using ``data`` as input. 2022-09-29T10:45:17.5036920Z 2022-09-29T10:45:17.5037250Z If the test raises an exception, it will propagate through to the 2022-09-29T10:45:17.5037650Z caller of this method. Depending on its type, this could represent 2022-09-29T10:45:17.5038139Z an ordinary test failure, or a fatal error, or a control exception. 2022-09-29T10:45:17.5038423Z 2022-09-29T10:45:17.5038740Z If this method returns normally, the test might have passed, or 2022-09-29T10:45:17.5039150Z it might have placed ``data`` in an unsuccessful state and then 2022-09-29T10:45:17.5039539Z swallowed the corresponding control exception. 2022-09-29T10:45:17.5039845Z """ 2022-09-29T10:45:17.5040233Z 2022-09-29T10:45:17.5040452Z self.ever_executed = True 2022-09-29T10:45:17.5040758Z data.is_find = self.is_find 2022-09-29T10:45:17.5041017Z 2022-09-29T10:45:17.5041268Z text_repr = None 2022-09-29T10:45:17.5041578Z if self.settings.deadline is None: 2022-09-29T10:45:17.5041833Z test = self.test 2022-09-29T10:45:17.5042072Z else: 2022-09-29T10:45:17.5042304Z 2022-09-29T10:45:17.5042557Z @proxies(self.test) 2022-09-29T10:45:17.5042857Z def test(*args, **kwargs): 2022-09-29T10:45:17.5043121Z self.__test_runtime = None 2022-09-29T10:45:17.5043434Z initial_draws = len(data.draw_times) 2022-09-29T10:45:17.5043772Z start = time.perf_counter() 2022-09-29T10:45:17.5044060Z result = self.test(*args, **kwargs) 2022-09-29T10:45:17.5044334Z finish = time.perf_counter() 2022-09-29T10:45:17.5044627Z internal_draw_time = sum(data.draw_times[initial_draws:]) 2022-09-29T10:45:17.5044956Z runtime = datetime.timedelta( 2022-09-29T10:45:17.5045396Z seconds=finish - start - internal_draw_time 2022-09-29T10:45:17.5045703Z ) 2022-09-29T10:45:17.5045995Z self.__test_runtime = runtime 2022-09-29T10:45:17.5046354Z current_deadline = self.settings.deadline 2022-09-29T10:45:17.5046631Z if not is_final: 2022-09-29T10:45:17.5046951Z current_deadline = (current_deadline // 4) * 5 2022-09-29T10:45:17.5047323Z if runtime >= current_deadline: 2022-09-29T10:45:17.5047706Z raise DeadlineExceeded(runtime, self.settings.deadline) 2022-09-29T10:45:17.5048050Z return result 2022-09-29T10:45:17.5048273Z 2022-09-29T10:45:17.5048502Z def run(data): 2022-09-29T10:45:17.5048832Z # Set up dynamic context needed by a single test run. 2022-09-29T10:45:17.5049193Z with local_settings(self.settings): 2022-09-29T10:45:17.5049522Z with deterministic_PRNG(): 2022-09-29T10:45:17.5049884Z with BuildContext(data, is_final=is_final): 2022-09-29T10:45:17.5050131Z 2022-09-29T10:45:17.5050442Z # Generate all arguments to the test function. 2022-09-29T10:45:17.5051031Z args, kwargs = data.draw(self.search_strategy) 2022-09-29T10:45:17.5051406Z if expected_failure is not None: 2022-09-29T10:45:17.5052090Z nonlocal text_repr 2022-09-29T10:45:17.5052532Z text_repr = repr_call(test, args, kwargs) 2022-09-29T10:45:17.5052941Z 2022-09-29T10:45:17.5053288Z if print_example or current_verbosity() >= Verbosity.verbose: 2022-09-29T10:45:17.5053668Z output = StringIO() 2022-09-29T10:45:17.5054053Z 2022-09-29T10:45:17.5054381Z printer = RepresentationPrinter(output) 2022-09-29T10:45:17.5054686Z if print_example: 2022-09-29T10:45:17.5055026Z printer.text("Falsifying example:") 2022-09-29T10:45:17.5055347Z else: 2022-09-29T10:45:17.5055646Z printer.text("Trying example:") 2022-09-29T10:45:17.5055929Z 2022-09-29T10:45:17.5056174Z if self.print_given_args: 2022-09-29T10:45:17.5056565Z printer.text(" ") 2022-09-29T10:45:17.5056902Z printer.text(test.__name__) 2022-09-29T10:45:17.5057247Z with printer.group(indent=4, open="(", close=""): 2022-09-29T10:45:17.5057601Z printer.break_() 2022-09-29T10:45:17.5057899Z for v in args: 2022-09-29T10:45:17.5058162Z printer.pretty(v) 2022-09-29T10:45:17.5058528Z # We add a comma unconditionally because 2022-09-29T10:45:17.5058922Z # generated arguments will always be kwargs, 2022-09-29T10:45:17.5059321Z # so there will always be more to come. 2022-09-29T10:45:17.5059652Z printer.text(",") 2022-09-29T10:45:17.5059992Z printer.breakable() 2022-09-29T10:45:17.5060230Z 2022-09-29T10:45:17.5060546Z for i, (k, v) in enumerate(kwargs.items()): 2022-09-29T10:45:17.5060886Z printer.text(k) 2022-09-29T10:45:17.5061211Z printer.text("=") 2022-09-29T10:45:17.5061731Z printer.pretty(v) 2022-09-29T10:45:17.5062062Z printer.text(",") 2022-09-29T10:45:17.5062342Z if i + 1 < len(kwargs): 2022-09-29T10:45:17.5062641Z printer.breakable() 2022-09-29T10:45:17.5062952Z printer.break_() 2022-09-29T10:45:17.5063282Z printer.text(")") 2022-09-29T10:45:17.5063610Z printer.flush() 2022-09-29T10:45:17.5063905Z report(output.getvalue()) 2022-09-29T10:45:17.5064230Z return test(*args, **kwargs) 2022-09-29T10:45:17.5064516Z 2022-09-29T10:45:17.5064817Z # Run the test function once, via the executor hook. 2022-09-29T10:45:17.5065193Z # In most cases this will delegate straight to `run(data)`. 2022-09-29T10:45:17.5065564Z result = self.test_runner(data, run) 2022-09-29T10:45:17.5065805Z 2022-09-29T10:45:17.5066132Z # If a failure was expected, it should have been raised already, so 2022-09-29T10:45:17.5066514Z # instead raise an appropriate diagnostic error. 2022-09-29T10:45:17.5066845Z if expected_failure is not None: 2022-09-29T10:45:17.5067184Z exception, traceback = expected_failure 2022-09-29T10:45:17.5067437Z if ( 2022-09-29T10:45:17.5067749Z isinstance(exception, DeadlineExceeded) 2022-09-29T10:45:17.5068095Z and self.__test_runtime is not None 2022-09-29T10:45:17.5068374Z ): 2022-09-29T10:45:17.5068623Z report( 2022-09-29T10:45:17.5068947Z "Unreliable test timings! On an initial run, this " 2022-09-29T10:45:17.5069387Z "test took %.2fms, which exceeded the deadline of " 2022-09-29T10:45:17.5069759Z "%.2fms, but on a subsequent run it took %.2f ms, " 2022-09-29T10:45:17.5070125Z "which did not. If you expect this sort of " 2022-09-29T10:45:17.5070497Z "variability in your test timings, consider turning " 2022-09-29T10:45:17.5070883Z "deadlines off for this test by setting deadline=None." 2022-09-29T10:45:17.5071181Z % ( 2022-09-29T10:45:17.5071463Z exception.runtime.total_seconds() * 1000, 2022-09-29T10:45:17.5071857Z self.settings.deadline.total_seconds() * 1000, 2022-09-29T10:45:17.5072242Z self.__test_runtime.total_seconds() * 1000, 2022-09-29T10:45:17.5072977Z ) 2022-09-29T10:45:17.5073202Z ) 2022-09-29T10:45:17.5073398Z else: 2022-09-29T10:45:17.5073749Z report("Failed to reproduce exception. Expected: \n" + traceback) 2022-09-29T10:45:17.5074092Z > raise Flaky( 2022-09-29T10:45:17.5074426Z f"Hypothesis {text_repr} produces unreliable results: " 2022-09-29T10:45:17.5074808Z "Falsified on the first call but did not on a subsequent one" 2022-09-29T10:45:17.5075137Z ) from exception 2022-09-29T10:45:17.5075962Z E hypothesis.errors.Flaky: Hypothesis test_datasaver_scalars(experiment=test-experiment#test-sample#1@C:\Users\runneradmin\AppData\Local\Temp\pytest-of-runneradmin\pytest-0\popen-gw0\test_datasaver_scalars0\temp.db 2022-09-29T10:45:17.5076835Z E ---------------------------------------------------------------------------------------------------------------------------------------------- 2022-09-29T10:45:17.5077388Z E 1-results-1-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5077810Z E 2-results-2-dummy_dac_ch1,dummy_dmm_v1-3 2022-09-29T10:45:17.5078201Z E 3-results-3-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5078611Z E 4-results-4-dummy_dac_ch1,dummy_dmm_v1-4 2022-09-29T10:45:17.5078956Z E 5-results-5-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5079351Z E 6-results-6-dummy_dac_ch1,dummy_dmm_v1-15 2022-09-29T10:45:17.5079760Z E 7-results-7-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5080164Z E 8-results-8-dummy_dac_ch1,dummy_dmm_v1-6 2022-09-29T10:45:17.5080568Z E 9-results-9-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5080985Z E 10-results-10-dummy_dac_ch1,dummy_dmm_v1-4 2022-09-29T10:45:17.5081355Z E 11-results-11-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5081767Z E 12-results-12-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5082173Z E 13-results-13-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5082573Z E 14-results-14-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5082982Z E 15-results-15-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5083386Z E 16-results-16-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5083744Z E 17-results-17-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5084130Z E 18-results-18-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5084529Z E 19-results-19-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5084935Z E 20-results-20-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5085331Z E 21-results-21-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5085902Z E 22-results-22-dummy_dac_ch1,dummy_dmm_v1-0, DAC=, DMM=, set_values=[0.0, 2022-09-29T10:45:17.5086262Z E 0.0, 2022-09-29T10:45:17.5086495Z E 0.0, 2022-09-29T10:45:17.5086749Z E 0.0, 2022-09-29T10:45:17.5086986Z E 0.0, 2022-09-29T10:45:17.5087285Z E 0.0, 2022-09-29T10:45:17.5087485Z E 0.0, 2022-09-29T10:45:17.5087721Z E 0.0, 2022-09-29T10:45:17.5087942Z E 0.0, 2022-09-29T10:45:17.5088185Z E 0.0, 2022-09-29T10:45:17.5088413Z E 0.0, 2022-09-29T10:45:17.5088610Z E 0.0, 2022-09-29T10:45:17.5088843Z E 0.0, 2022-09-29T10:45:17.5089079Z E 0.0, 2022-09-29T10:45:17.5089313Z E 0.0, 2022-09-29T10:45:17.5089529Z E 0.0, 2022-09-29T10:45:17.5089719Z E 0.0, 2022-09-29T10:45:17.5089955Z E 0.0, 2022-09-29T10:45:17.5090170Z E 0.0, 2022-09-29T10:45:17.5090431Z E 0.0], get_values=[0.0, 2022-09-29T10:45:17.5090701Z E 0.0, 2022-09-29T10:45:17.5090899Z E 0.0, 2022-09-29T10:45:17.5091141Z E 0.0, 2022-09-29T10:45:17.5091350Z E 0.0, 2022-09-29T10:45:17.5091956Z E 0.0, 2022-09-29T10:45:17.5092208Z E 0.0, 2022-09-29T10:45:17.5092411Z E 0.0, 2022-09-29T10:45:17.5092648Z E 0.0, 2022-09-29T10:45:17.5092877Z E 0.0, 2022-09-29T10:45:17.5093105Z E 0.0, 2022-09-29T10:45:17.5093340Z E 0.0, 2022-09-29T10:45:17.5093513Z E 0.0, 2022-09-29T10:45:17.5093744Z E 0.0, 2022-09-29T10:45:17.5093976Z E 0.0, 2022-09-29T10:45:17.5094197Z E 0.0, 2022-09-29T10:45:17.5094395Z E 0.0, 2022-09-29T10:45:17.5094617Z E 0.0, 2022-09-29T10:45:17.5094849Z E 0.0, 2022-09-29T10:45:17.5095273Z E 0.0], breakpoint=1, write_period=0.1) produces unreliable results: Falsified on the first call but did not on a subsequent one 2022-09-29T10:45:17.5095720Z E Falsifying example: test_datasaver_scalars( 2022-09-29T10:45:17.5096035Z E breakpoint=1, 2022-09-29T10:45:17.5096283Z E write_period=0.1, 2022-09-29T10:45:17.5096555Z E set_values=[0.0, 2022-09-29T10:45:17.5096810Z E 0.0, 2022-09-29T10:45:17.5097075Z E 0.0, 2022-09-29T10:45:17.5097306Z E 0.0, 2022-09-29T10:45:17.5097510Z E 0.0, 2022-09-29T10:45:17.5097760Z E 0.0, 2022-09-29T10:45:17.5097993Z E 0.0, 2022-09-29T10:45:17.5098218Z E 0.0, 2022-09-29T10:45:17.5098456Z E 0.0, 2022-09-29T10:45:17.5098650Z E 0.0, 2022-09-29T10:45:17.5098892Z E 0.0, 2022-09-29T10:45:17.5099115Z E 0.0, 2022-09-29T10:45:17.5099348Z E 0.0, 2022-09-29T10:45:17.5099583Z E 0.0, 2022-09-29T10:45:17.5099777Z E 0.0, 2022-09-29T10:45:17.5100022Z E 0.0, 2022-09-29T10:45:17.5100276Z E 0.0, 2022-09-29T10:45:17.5100499Z E 0.0, 2022-09-29T10:45:17.5100740Z E 0.0, 2022-09-29T10:45:17.5100947Z E 0.0], 2022-09-29T10:45:17.5101188Z E get_values=[0.0, 2022-09-29T10:45:17.5101457Z E 0.0, 2022-09-29T10:45:17.5101692Z E 0.0, 2022-09-29T10:45:17.5101937Z E 0.0, 2022-09-29T10:45:17.5102129Z E 0.0, 2022-09-29T10:45:17.5102352Z E 0.0, 2022-09-29T10:45:17.5102595Z E 0.0, 2022-09-29T10:45:17.5102833Z E 0.0, 2022-09-29T10:45:17.5103067Z E 0.0, 2022-09-29T10:45:17.5103265Z E 0.0, 2022-09-29T10:45:17.5103513Z E 0.0, 2022-09-29T10:45:17.5103752Z E 0.0, 2022-09-29T10:45:17.5103990Z E 0.0, 2022-09-29T10:45:17.5104206Z E 0.0, 2022-09-29T10:45:17.5104407Z E 0.0, 2022-09-29T10:45:17.5104651Z E 0.0, 2022-09-29T10:45:17.5104871Z E 0.0, 2022-09-29T10:45:17.5105114Z E 0.0, 2022-09-29T10:45:17.5105351Z E 0.0, 2022-09-29T10:45:17.5105556Z E 0.0], 2022-09-29T10:45:17.5106266Z E experiment=test-experiment#test-sample#1@C:\Users\runneradmin\AppData\Local\Temp\pytest-of-runneradmin\pytest-0\popen-gw0\test_datasaver_scalars0\temp.db 2022-09-29T10:45:17.5107201Z E ---------------------------------------------------------------------------------------------------------------------------------------------- 2022-09-29T10:45:17.5107772Z E 1-results-1-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5108196Z E 2-results-2-dummy_dac_ch1,dummy_dmm_v1-3 2022-09-29T10:45:17.5108617Z E 3-results-3-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5109023Z E 4-results-4-dummy_dac_ch1,dummy_dmm_v1-4 2022-09-29T10:45:17.5109397Z E 5-results-5-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5109810Z E 6-results-6-dummy_dac_ch1,dummy_dmm_v1-15 2022-09-29T10:45:17.5110661Z E 7-results-7-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5111099Z E 8-results-8-dummy_dac_ch1,dummy_dmm_v1-6 2022-09-29T10:45:17.5111563Z E 9-results-9-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5111930Z E 10-results-10-dummy_dac_ch1,dummy_dmm_v1-4 2022-09-29T10:45:17.5112351Z E 11-results-11-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5112815Z E 12-results-12-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5113216Z E 13-results-13-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5113628Z E 14-results-14-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5114008Z E 15-results-15-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5114375Z E 16-results-16-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5114782Z E 17-results-17-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5115184Z E 18-results-18-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5115596Z E 19-results-19-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5115996Z E 20-results-20-dummy_dac_ch1,dummy_dmm_v1-0 2022-09-29T10:45:17.5116405Z E 21-results-21-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5116771Z E 22-results-22-dummy_dac_ch1,dummy_dmm_v1-0, 2022-09-29T10:45:17.5117112Z E DAC=, 2022-09-29T10:45:17.5117454Z E DMM=, 2022-09-29T10:45:17.5117750Z E ) 2022-09-29T10:45:17.5118062Z E Failed to reproduce exception. Expected: 2022-09-29T10:45:17.5118864Z E experiment = test-experiment#test-sample#1@C:\Users\runneradmin\AppData\Local\Temp\pytest-of-runneradmin\pytest-0\popen-gw0\test_da...------------------------------------------------------------------------------ 2022-09-29T10:45:17.5119518Z E 1-results-1-dummy_dac_ch1,dummy_dmm_v1-2 2022-09-29T10:45:17.5119924Z E DAC = , DMM = 2022-09-29T10:45:17.5120302Z E set_values = [0.0, 0.0, 0.0, 0.0, 0.0, 0.0, ...] 2022-09-29T10:45:17.5120645Z E get_values = [0.0, 0.0, 0.0, 0.0, 0.0, 0.0, ...], breakpoint = 1 2022-09-29T10:45:17.5120948Z E write_period = 0.1 2022-09-29T10:45:17.5121216Z E 2022-09-29T10:45:17.5121474Z E @settings(max_examples=5, deadline=None, 2022-09-29T10:45:17.5121864Z E suppress_health_check=(HealthCheck.function_scoped_fixture,)) 2022-09-29T10:45:17.5122298Z E @given(breakpoint=hst.integers(min_value=1, max_value=19), 2022-09-29T10:45:17.5122675Z E write_period=hst.floats(min_value=0.1, max_value=1.5), 2022-09-29T10:45:17.5123088Z E set_values=hst.lists(elements=hst.floats(), min_size=20, max_size=20), 2022-09-29T10:45:17.5123507Z E get_values=hst.lists(elements=hst.floats(), min_size=20, max_size=20)) 2022-09-29T10:45:17.5123968Z E @pytest.mark.usefixtures('set_default_station_to_none') 2022-09-29T10:45:17.5124489Z E def test_datasaver_scalars(experiment, DAC, DMM, set_values, get_values, 2022-09-29T10:45:17.5124880Z E breakpoint, write_period): 2022-09-29T10:45:17.5125192Z E no_of_runs = len(experiment) 2022-09-29T10:45:17.5125451Z E 2022-09-29T10:45:17.5125729Z E station = qc.Station(DAC, DMM) 2022-09-29T10:45:17.5125970Z E 2022-09-29T10:45:17.5126276Z E meas = Measurement(station=station) 2022-09-29T10:45:17.5126608Z E meas.write_period = write_period 2022-09-29T10:45:17.5126881Z E 2022-09-29T10:45:17.5127186Z E assert meas.write_period == write_period 2022-09-29T10:45:17.5127412Z E 2022-09-29T10:45:17.5127707Z E meas.register_parameter(DAC.ch1) 2022-09-29T10:45:17.5128145Z E meas.register_parameter(DMM.v1, setpoints=(DAC.ch1,)) 2022-09-29T10:45:17.5128466Z E 2022-09-29T10:45:17.5128741Z E with meas.run() as datasaver: 2022-09-29T10:45:17.5129090Z E for set_v, get_v in zip(set_values[:breakpoint], 2022-09-29T10:45:17.5129413Z E get_values[:breakpoint]): 2022-09-29T10:45:17.5129784Z E datasaver.add_result((DAC.ch1, set_v), (DMM.v1, get_v)) 2022-09-29T10:45:17.5130107Z E 2022-09-29T10:45:17.5130433Z E assert datasaver._dataset.number_of_results == 0 2022-09-29T10:45:17.5130778Z E sleep(write_period * 1.1) 2022-09-29T10:45:17.5131147Z E datasaver.add_result((DAC.ch1, set_values[breakpoint]), 2022-09-29T10:45:17.5131487Z E (DMM.v1, get_values[breakpoint])) 2022-09-29T10:45:17.5131857Z E > assert datasaver.points_written == breakpoint + 1 2022-09-29T10:45:17.5132213Z E E assert 0 == (1 + 1) 2022-09-29T10:45:17.5132631Z E E + where 0 = .points_written 2022-09-29T10:45:17.5133020Z E 2022-09-29T10:45:17.5133409Z E qcodes\tests\dataset\measurement\test_measurement_context_manager.py:626: AssertionError 2022-09-29T10:45:17.5133746Z E 2022-09-29T10:45:17.5133986Z E 2022-09-29T10:45:17.5134602Z E You can reproduce this example by temporarily adding @reproduce_failure('6.54.6', b'AXicY2BAAgdMZ4IBwygYkgAA5R4EjA==') as a decorator on your test case 2022-09-29T10:45:17.5134958Z 2022-09-29T10:45:17.5135314Z C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\site-packages\hypothesis\core.py:717: Flaky 2022-09-29T10:45:17.5135907Z ----------------------------- Captured log setup ------------------------------ 2022-09-29T10:45:17.5136483Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:135 Commencing database upgrade 2022-09-29T10:45:17.5137049Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 0 to 1 2022-09-29T10:45:17.5137641Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 0 -> 1 2022-09-29T10:45:17.5138259Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 1 to 2 2022-09-29T10:45:17.5138884Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 1 -> 2 2022-09-29T10:45:17.5139465Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 2 to 3 2022-09-29T10:45:17.5140063Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 2 -> 3 2022-09-29T10:45:17.5140683Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 3 to 4 2022-09-29T10:45:17.5141246Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 3 -> 4 2022-09-29T10:45:17.5141908Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 4 to 5 2022-09-29T10:45:17.5142508Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 4 -> 5 2022-09-29T10:45:17.5143160Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 5 to 6 2022-09-29T10:45:17.5143741Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 5 -> 6 2022-09-29T10:45:17.5144344Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 6 to 7 2022-09-29T10:45:17.5144955Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 6 -> 7 2022-09-29T10:45:17.5145604Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 7 to 8 2022-09-29T10:45:17.5146166Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 7 -> 8 2022-09-29T10:45:17.5146755Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:95 Starting database upgrade version 8 to 9 2022-09-29T10:45:17.5147356Z INFO  qcodes.dataset.sqlite.db_upgrades:__init__.py:108 Succesfully performed upgrade 8 -> 9 2022-09-29T10:45:17.5148217Z INFO  qcodes.dataset.experiment_container:experiment_container.py:86 creating new experiment in C:\Users\runneradmin\AppData\Local\Temp\pytest-of-runneradmin\pytest-0\popen-gw0\test_datasaver_scalars0\temp.db 2022-09-29T10:45:17.5148975Z ---------------------------- Captured stdout call ----------------------------- 2022-09-29T10:45:17.5149355Z Starting experimental run with id: 1. 2022-09-29T10:45:17.5149698Z Starting experimental run with id: 2. 2022-09-29T10:45:17.5149988Z Starting experimental run with id: 3. 2022-09-29T10:45:17.5150307Z Starting experimental run with id: 4. 2022-09-29T10:45:17.5150635Z Starting experimental run with id: 5. 2022-09-29T10:45:17.5150969Z Starting experimental run with id: 6. 2022-09-29T10:45:17.5151309Z Starting experimental run with id: 7. 2022-09-29T10:45:17.5151596Z Starting experimental run with id: 8. 2022-09-29T10:45:17.5151922Z Starting experimental run with id: 9. 2022-09-29T10:45:17.5152266Z Starting experimental run with id: 10. 2022-09-29T10:45:17.5152591Z Starting experimental run with id: 11. 2022-09-29T10:45:17.5152923Z Starting experimental run with id: 12. 2022-09-29T10:45:17.5153213Z Starting experimental run with id: 13. 2022-09-29T10:45:17.5153537Z Starting experimental run with id: 14. 2022-09-29T10:45:17.5153861Z Starting experimental run with id: 15. 2022-09-29T10:45:17.5154185Z Starting experimental run with id: 16. 2022-09-29T10:45:17.5154507Z Starting experimental run with id: 17. 2022-09-29T10:45:17.5154840Z Starting experimental run with id: 18. 2022-09-29T10:45:17.5155123Z Starting experimental run with id: 19. 2022-09-29T10:45:17.5155447Z Starting experimental run with id: 20. 2022-09-29T10:45:17.5155775Z Starting experimental run with id: 21. 2022-09-29T10:45:17.5156100Z Starting experimental run with id: 22. 2022-09-29T10:45:17.5156425Z Starting experimental run with id: 23. 2022-09-29T10:45:17.5156696Z Starting experimental run with id: 24. 2022-09-29T10:45:17.5157140Z ---------------------------- Captured stderr call ----------------------------- 2022-09-29T10:45:17.5417106Z 2022-09-29 10:41:01,608 � qcodes.dataset.measurements � WARNING � measurements � __exit__ � 665 � An exception occured in measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e01a; 2022-09-29T10:45:17.5417686Z Traceback: 2022-09-29T10:45:17.5417944Z Traceback (most recent call last): 2022-09-29T10:45:17.5418771Z File "D:\a\Qcodes\Qcodes\qcodes\tests\dataset\measurement\test_measurement_context_manager.py", line 626, in test_datasaver_scalars 2022-09-29T10:45:17.5419467Z assert datasaver.points_written == breakpoint + 1 2022-09-29T10:45:17.5419826Z AssertionError: assert 0 == (1 + 1) 2022-09-29T10:45:17.5420210Z + where 0 = .points_written 2022-09-29T10:45:17.5420483Z 2022-09-29T10:45:17.5421149Z 2022-09-29 10:41:06,579 � qcodes.dataset.measurements � WARNING � measurements � __exit__ � 665 � An exception occured in measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f372; 2022-09-29T10:45:17.5421550Z Traceback: 2022-09-29T10:45:17.5421820Z Traceback (most recent call last): 2022-09-29T10:45:17.5422314Z File "D:\a\Qcodes\Qcodes\qcodes\tests\dataset\measurement\test_measurement_context_manager.py", line 626, in test_datasaver_scalars 2022-09-29T10:45:17.5422798Z assert datasaver.points_written == breakpoint + 1 2022-09-29T10:45:17.5423128Z AssertionError: assert 0 == (1 + 1) 2022-09-29T10:45:17.5423634Z + where 0 = .points_written 2022-09-29T10:45:17.5423916Z 2022-09-29T10:45:17.5424204Z ------------------------------ Captured log call ------------------------------ 2022-09-29T10:45:17.5424826Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5425444Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5426089Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 1 to 1664448061.4973001 2022-09-29T10:45:17.5426925Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e01a, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5427658Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5428211Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5428761Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5429409Z WARNING  qcodes.dataset.measurements:measurements.py:665 An exception occured in measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e01a; 2022-09-29T10:45:17.5429824Z Traceback: 2022-09-29T10:45:17.5430103Z Traceback (most recent call last): 2022-09-29T10:45:17.5430641Z File "D:\a\Qcodes\Qcodes\qcodes\tests\dataset\measurement\test_measurement_context_manager.py", line 626, in test_datasaver_scalars 2022-09-29T10:45:17.5431134Z assert datasaver.points_written == breakpoint + 1 2022-09-29T10:45:17.5431486Z AssertionError: assert 0 == (1 + 1) 2022-09-29T10:45:17.5431869Z + where 0 = .points_written 2022-09-29T10:45:17.5432152Z 2022-09-29T10:45:17.5432580Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e01a. 2022-09-29T10:45:17.5433264Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5433876Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5434522Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 2 to 1664448061.7492862 2022-09-29T10:45:17.5435335Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e126, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5436051Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5436601Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5437934Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5438427Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5438937Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5439576Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e126. 2022-09-29T10:45:17.5440249Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 3 to 1664448062.3308403 2022-09-29T10:45:17.5441075Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e35c, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5441883Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5442433Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5442904Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5443544Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e35c. 2022-09-29T10:45:17.5444205Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5444857Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5445471Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 4 to 1664448062.377767 2022-09-29T10:45:17.5446304Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e38a, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5447042Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5447584Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5448090Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5448605Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5449112Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5449758Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e38a. 2022-09-29T10:45:17.5450417Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 5 to 1664448062.9592807 2022-09-29T10:45:17.5451239Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e5d0, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5451966Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5452507Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5452969Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5453580Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e5d0. 2022-09-29T10:45:17.5454255Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5454867Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5455509Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 6 to 1664448063.0061545 2022-09-29T10:45:17.5456416Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e5ff, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5457139Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5457637Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5458167Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5458686Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5459192Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5459900Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e5ff. 2022-09-29T10:45:17.5460591Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 7 to 1664448063.196229 2022-09-29T10:45:17.5461405Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e69b, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5462133Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5462634Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5463139Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5463774Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e69b. 2022-09-29T10:45:17.5464413Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5465050Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5465694Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 8 to 1664448063.289995 2022-09-29T10:45:17.5466518Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e70b, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5467249Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5467753Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5468303Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5468834Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5469349Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5469988Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5e70b. 2022-09-29T10:45:17.5470664Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 9 to 1664448064.9537747 2022-09-29T10:45:17.5471480Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5ed9b, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5472169Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5472702Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5473185Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5473884Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5ed9b. 2022-09-29T10:45:17.5474552Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5475186Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5475785Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 10 to 1664448065.0525692 2022-09-29T10:45:17.5476567Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5ede9, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5477297Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5477834Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5478376Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5478883Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5479347Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5479941Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5ede9. 2022-09-29T10:45:17.5480583Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 11 to 1664448066.370988 2022-09-29T10:45:17.5481348Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f324, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5482064Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5482597Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5483113Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5483736Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f324. 2022-09-29T10:45:17.5484411Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5485022Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5485659Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 12 to 1664448066.4675055 2022-09-29T10:45:17.5486427Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f372, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5487150Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5487687Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5488217Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5488910Z WARNING  qcodes.dataset.measurements:measurements.py:665 An exception occured in measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f372; 2022-09-29T10:45:17.5489363Z Traceback: 2022-09-29T10:45:17.5489638Z Traceback (most recent call last): 2022-09-29T10:45:17.5490209Z File "D:\a\Qcodes\Qcodes\qcodes\tests\dataset\measurement\test_measurement_context_manager.py", line 626, in test_datasaver_scalars 2022-09-29T10:45:17.5490732Z assert datasaver.points_written == breakpoint + 1 2022-09-29T10:45:17.5491158Z AssertionError: assert 0 == (1 + 1) 2022-09-29T10:45:17.5491587Z + where 0 = .points_written 2022-09-29T10:45:17.5491860Z 2022-09-29T10:45:17.5492286Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f372. 2022-09-29T10:45:17.5492962Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5493575Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5494220Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 13 to 1664448066.7516267 2022-09-29T10:45:17.5495037Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f4a0, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5495770Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5496317Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5496832Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5497362Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5497868Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5498522Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f4a0. 2022-09-29T10:45:17.5499147Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 14 to 1664448066.9078777 2022-09-29T10:45:17.5499971Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f53d, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5500693Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5501242Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5501745Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5502390Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f53d. 2022-09-29T10:45:17.5503038Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5503670Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5504262Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 15 to 1664448067.2054517 2022-09-29T10:45:17.5505076Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f666, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5505808Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5506351Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5506891Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5507410Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5507911Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5508514Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f666. 2022-09-29T10:45:17.5509222Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 16 to 1664448067.3611047 2022-09-29T10:45:17.5510029Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f702, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5510750Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5511305Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5511794Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5512480Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f702. 2022-09-29T10:45:17.5513186Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5513774Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5514400Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 17 to 1664448067.439229 2022-09-29T10:45:17.5515174Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f750, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5515846Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5516343Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5516830Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5517302Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5517754Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5518326Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f750. 2022-09-29T10:45:17.5518943Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 18 to 1664448067.6277983 2022-09-29T10:45:17.5519707Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f7fd, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5520384Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5520875Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5521328Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5521916Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f7fd. 2022-09-29T10:45:17.5522504Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5523079Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5523663Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 19 to 1664448067.7219145 2022-09-29T10:45:17.5524419Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f85b, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5525101Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5525651Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5526134Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5526700Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5527133Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5527720Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f85b. 2022-09-29T10:45:17.5528337Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 20 to 1664448067.8797724 2022-09-29T10:45:17.5529141Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f909, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5529817Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5530310Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5530764Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5531346Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5f909. 2022-09-29T10:45:17.5531939Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5532513Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5533098Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 21 to 1664448068.223969 2022-09-29T10:45:17.5533860Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5fa51, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5534539Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5535031Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5535516Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5535966Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5536415Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5537016Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5fa51. 2022-09-29T10:45:17.5537630Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 22 to 1664448068.4238226 2022-09-29T10:45:17.5538389Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d5fb16, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5539057Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5539548Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5540002Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5540567Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d5fb16. 2022-09-29T10:45:17.5541174Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dac_ch1 in the Measurement. 2022-09-29T10:45:17.5541760Z INFO  qcodes.dataset.measurements:measurements.py:964 Registered dummy_dmm_v1 in the Measurement. 2022-09-29T10:45:17.5542394Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 23 to 1664448070.2848785 2022-09-29T10:45:17.5543158Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d6026e, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5543823Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5544324Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5544806Z DEBUG  qcodes.dataset.data_set:data_set.py:1412 Successfully wrote result to disk 2022-09-29T10:45:17.5545262Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5545753Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5546338Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d6026e. 2022-09-29T10:45:17.5546958Z INFO  qcodes.dataset.sqlite.queries:queries.py:1496 Set the run_timestamp of run_id 24 to 1664448070.44113 2022-09-29T10:45:17.5547713Z INFO  qcodes.dataset.measurements:measurements.py:627 Starting measurement with guid: aaaaaaaa-0000-0000-0000-018388d6030a, sample_name: "test-sample", exp_name: "test-experiment", ds_name: "results". 2022-09-29T10:45:17.5548381Z INFO  qcodes.dataset.measurements:measurements.py:634 Using background writing: False 2022-09-29T10:45:17.5548873Z DEBUG  qcodes.dataset.data_set:data_set.py:1403 Flushing to database 2022-09-29T10:45:17.5549307Z DEBUG  qcodes.dataset.data_set:data_set.py:1420 No results to flush 2022-09-29T10:45:17.5549723Z NoTagError: `git describe` could not find a tag 2022-09-29T10:45:17.5550058Z Matplotlib is building the font cache; this may take a moment. 2022-09-29T10:45:17.5550630Z INFO  qcodes.dataset.measurements:measurements.py:676 Finished measurement with guid: aaaaaaaa-0000-0000-0000-018388d6030a. 2022-09-29T10:45:17.5551052Z ============================== warnings summary =============================== 2022-09-29T10:45:17.5551340Z qcodes\tests\test_instrument.py:430 2022-09-29T10:45:17.5551619Z qcodes\tests\test_instrument.py:430 2022-09-29T10:45:17.5552296Z D:\a\Qcodes\Qcodes\qcodes\tests\test_instrument.py:430: PytestCollectionWarning: cannot collect test class 'TestSnapshotType' because it has a __init__ constructor (from: qcodes/tests/test_instrument.py) 2022-09-29T10:45:17.5552831Z class TestSnapshotType(Metadatable): 2022-09-29T10:45:17.5553009Z 2022-09-29T10:45:17.5553129Z qcodes\tests\test_instrument.py:439 2022-09-29T10:45:17.5553407Z qcodes\tests\test_instrument.py:439 2022-09-29T10:45:17.5554087Z D:\a\Qcodes\Qcodes\qcodes\tests\test_instrument.py:439: PytestCollectionWarning: cannot collect test class 'TestInstrument' because it has a __init__ constructor (from: qcodes/tests/test_instrument.py) 2022-09-29T10:45:17.5554599Z class TestInstrument(InstrumentBase): 2022-09-29T10:45:17.5554770Z 2022-09-29T10:45:17.5554890Z qcodes/tests/test_monitor.py: 8 warnings 2022-09-29T10:45:17.5555149Z qcodes/tests/test_station.py: 2 warnings 2022-09-29T10:45:17.5555742Z C:\hostedtoolcache\windows\Python\3.10.7\x64\lib\site-packages\websockets\legacy\server.py:1006: DeprecationWarning: There is no current event loop 2022-09-29T10:45:17.5556174Z loop = asyncio.get_event_loop() 2022-09-29T10:45:17.5556328Z 2022-09-29T10:45:17.5556610Z -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 2022-09-29T10:45:17.5556841Z 2022-09-29T10:45:17.5557087Z ---------- coverage: platform win32, python 3.10.7-final-0 ----------- 2022-09-29T10:45:17.5557415Z Coverage XML written to file coverage.xml 2022-09-29T10:45:17.5557578Z 2022-09-29T10:45:17.5557721Z =========================== short test summary info =========================== 2022-09-29T10:45:17.5558198Z FAILED qcodes/tests/dataset/measurement/test_measurement_context_manager.py::test_datasaver_scalars 2022-09-29T10:45:17.5558619Z = 1 failed, 2668 passed, 233 skipped, 6 xfailed, 3 xpassed, 14 warnings in 1004.65s (0:16:44) = 2022-09-29T10:45:18.3060770Z ##[error]Process completed with exit code 1. 2022-09-29T10:45:18.3252682Z Post job cleanup. 2022-09-29T10:45:20.9071051Z [command]"C:\Program Files\Git\bin\git.exe" version 2022-09-29T10:45:20.9285385Z git version 2.37.3.windows.1 2022-09-29T10:45:20.9365790Z Temporarily overriding HOME='D:\a\_temp\85c540a4-04f5-4e47-9218-dc30c352e5ae' before making global git config changes 2022-09-29T10:45:20.9369819Z Adding repository directory to the temporary git global config as a safe directory 2022-09-29T10:45:20.9370717Z [command]"C:\Program Files\Git\bin\git.exe" config --global --add safe.directory D:\a\Qcodes\Qcodes 2022-09-29T10:45:20.9620339Z [command]"C:\Program Files\Git\bin\git.exe" config --local --name-only --get-regexp core\.sshCommand 2022-09-29T10:45:20.9859535Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach --recursive "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :" 2022-09-29T10:45:21.4597790Z Entering 'qcodes/tests/dataset/fixtures/db_files' 2022-09-29T10:45:21.5301209Z [command]"C:\Program Files\Git\bin\git.exe" config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader 2022-09-29T10:45:21.5502805Z http.https://github.com/.extraheader 2022-09-29T10:45:21.5536386Z [command]"C:\Program Files\Git\bin\git.exe" config --local --unset-all http.https://github.com/.extraheader 2022-09-29T10:45:21.5771192Z [command]"C:\Program Files\Git\bin\git.exe" submodule foreach --recursive "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :" 2022-09-29T10:45:22.0240934Z Entering 'qcodes/tests/dataset/fixtures/db_files' 2022-09-29T10:45:22.0670153Z http.https://github.com/.extraheader 2022-09-29T10:45:22.1482666Z Cleaning up orphan processes