[57.322044] Initializing watchdogs
[57.322091]   /dev/watchdog0
[57.336428] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.340694] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.342868] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.346060] [001/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[57.478801] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[61.167442] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.676s)
[62.363732] [002/132] (955s left) kms_pm_rpm (modeset-lpsp-stress)
[64.017136] Starting subtest: modeset-lpsp-stress
[79.796706] Subtest modeset-lpsp-stress: SUCCESS (15.765s)
[79.923332] [003/132] (938s left) kms_plane_scaling (2x-scaler-multi-pipe)
[80.019780] Starting subtest: 2x-scaler-multi-pipe
[80.024287] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[80.144016] [004/132] (937s left) kms_cursor_crc (cursor-sliding-256x256)
[80.363110] Starting subtest: cursor-sliding-256x256
[80.365555] Starting dynamic subtest: pipe-A-eDP-1
[83.562215] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.195s)
[83.591945] Starting dynamic subtest: pipe-D-eDP-1
[87.441965] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.854s)
[87.444168] Subtest cursor-sliding-256x256: SUCCESS (7.076s)
[88.327798] [005/132] (929s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[88.439131] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[88.443496] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[88.579918] [006/132] (929s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[88.676443] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[88.678667] Starting dynamic subtest: pipe-A-eDP-1
[88.816751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.132s)
[88.826102] Starting dynamic subtest: pipe-B-eDP-1
[88.846201] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[88.852944] Starting dynamic subtest: pipe-C-eDP-1
[88.872227] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[88.879136] Starting dynamic subtest: pipe-D-eDP-1
[88.899753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[88.901700] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.140s)
[91.089650] [007/132] (927s left) kms_plane_multiple (tiling-4)
[91.185138] Starting subtest: tiling-4
[91.187519] Starting dynamic subtest: pipe-A-eDP-1
[94.907091] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.723s)
[94.915196] Starting dynamic subtest: pipe-B-eDP-1
[99.259029] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.349s)
[99.267147] Starting dynamic subtest: pipe-C-eDP-1
[103.589980] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.330s)
[103.599356] Starting dynamic subtest: pipe-D-eDP-1
[107.932205] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.340s)
[107.934596] Subtest tiling-4: SUCCESS (16.746s)
[108.763561] [008/132] (909s left) gem_wait (write-busy)
[108.829869] Starting subtest: write-busy
[108.832300] Starting dynamic subtest: all-engines
[109.475822] Dynamic subtest all-engines: SUCCESS (0.646s)
[109.490694] Starting dynamic subtest: rcs0
[110.026166] Dynamic subtest rcs0: SUCCESS (0.549s)
[110.040065] Starting dynamic subtest: bcs0
[110.573599] Dynamic subtest bcs0: SUCCESS (0.546s)
[110.587805] Starting dynamic subtest: vcs0
[111.893717] Dynamic subtest vcs0: SUCCESS (1.318s)
[111.908213] Starting dynamic subtest: vcs1
[113.941081] Dynamic subtest vcs1: SUCCESS (2.046s)
[113.954731] Starting dynamic subtest: vecs0
[115.925075] Dynamic subtest vecs0: SUCCESS (1.982s)
[115.939061] Starting dynamic subtest: ccs0
[116.473958] Dynamic subtest ccs0: SUCCESS (0.549s)
[116.476491] Subtest write-busy: SUCCESS (7.644s)
[116.687763] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[116.690970] [009/132] (901s left) perf_pmu (init-busy)
[116.746227] Starting subtest: init-busy
[116.748723] Starting dynamic subtest: rcs0
[116.751133] Dynamic subtest rcs0: SUCCESS (0.001s)
[116.759729] Starting dynamic subtest: bcs0
[116.762087] Dynamic subtest bcs0: SUCCESS (0.000s)
[116.769177] Starting dynamic subtest: vcs0
[116.771331] Dynamic subtest vcs0: SUCCESS (0.001s)
[116.780408] Starting dynamic subtest: vcs1
[116.782357] Dynamic subtest vcs1: SUCCESS (0.001s)
[116.788863] Starting dynamic subtest: vecs0
[116.790803] Dynamic subtest vecs0: SUCCESS (0.001s)
[116.799697] Starting dynamic subtest: ccs0
[116.801792] Dynamic subtest ccs0: SUCCESS (0.000s)
[116.803976] Subtest init-busy: SUCCESS (0.006s)
[116.893478] [010/132] (901s left) syncobj_timeline (signal-point-0)
[116.955576] Starting subtest: signal-point-0
[116.957791] Subtest signal-point-0: SUCCESS (0.000s)
[117.075324] [011/132] (901s left) perf (invalid-remove-userspace-config)
[117.221282] Starting subtest: invalid-remove-userspace-config
[117.227645] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[117.273935] [012/132] (901s left) kms_vrr (flip-basic-fastset)
[117.372710] Starting subtest: flip-basic-fastset
[117.379105] Subtest flip-basic-fastset: SKIP (0.000s)
[117.467194] [013/132] (900s left) kms_psr (psr-sprite-blt)
[117.567082] Starting subtest: psr-sprite-blt
[117.569373] Starting dynamic subtest: eDP-1
[119.289672] Dynamic subtest eDP-1: SUCCESS (1.724s)
[119.292104] Subtest psr-sprite-blt: SUCCESS (1.725s)
[120.129857] [014/132] (898s left) gem_exec_schedule (pi-common)
[120.313358] Starting subtest: pi-common
[120.315610] Starting dynamic subtest: rcs0
[120.337495] Dynamic subtest rcs0: SUCCESS (0.027s)
[120.351170] Starting dynamic subtest: bcs0
[120.364126] Dynamic subtest bcs0: SUCCESS (0.026s)
[120.374916] Starting dynamic subtest: vcs0
[120.390470] Dynamic subtest vcs0: SUCCESS (0.026s)
[120.402193] Starting dynamic subtest: vcs1
[120.415245] Dynamic subtest vcs1: SUCCESS (0.024s)
[120.426917] Starting dynamic subtest: vecs0
[120.440283] Dynamic subtest vecs0: SUCCESS (0.025s)
[120.452223] Starting dynamic subtest: ccs0
[120.465780] Dynamic subtest ccs0: SUCCESS (0.025s)
[120.468097] Subtest pi-common: SUCCESS (0.155s)
[120.709762] [015/132] (897s left) kms_prop_blob (blob-prop-validate)
[120.769871] Starting subtest: blob-prop-validate
[120.771796] Subtest blob-prop-validate: SUCCESS (0.000s)
[120.905208] [016/132] (897s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[121.018608] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[125.422565] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.408s)
[126.614987] [017/132] (891s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[126.742853] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[127.700857] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[128.534461] [018/132] (889s left) perf_pmu (interrupts)
[128.578808] Starting subtest: interrupts
[129.666116] Subtest interrupts: SUCCESS (1.086s)
[129.810734] [019/132] (888s left) kms_psr (psr2-primary-mmap-cpu)
[129.901038] Starting subtest: psr2-primary-mmap-cpu
[129.903340] Starting dynamic subtest: eDP-1
[131.606925] Dynamic subtest eDP-1: SUCCESS (1.706s)
[131.609168] Subtest psr2-primary-mmap-cpu: SUCCESS (1.706s)
[132.507032] [020/132] (886s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[132.569922] Starting subtest: wait-all-for-submit-delayed-submit
[132.673635] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[132.771457] [021/132] (885s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[137.801937] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[137.812638] Starting dynamic subtest: pipe-A-eDP-1
[138.592587] Dynamic subtest pipe-A-eDP-1: SKIP (0.773s)
[138.614727] Starting dynamic subtest: pipe-B-eDP-1
[139.728497] Dynamic subtest pipe-B-eDP-1: SKIP (1.141s)
[139.750670] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.918s)
[140.958182] [022/132] (877s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[141.073746] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[141.076384] Starting dynamic subtest: pipe-A-eDP-1
[141.133753] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[141.141714] Starting dynamic subtest: pipe-B-eDP-1
[141.196030] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[141.204726] Starting dynamic subtest: pipe-C-eDP-1
[141.258668] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[141.266913] Starting dynamic subtest: pipe-D-eDP-1
[141.326650] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[141.330952] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[143.295190] [023/132] (875s left) gem_exec_balancer (nop)
[143.368486] Starting subtest: nop
[190.038135] Subtest nop: SUCCESS (46.667s)
[190.363790] [024/132] (828s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[190.479950] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[190.491322] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[190.591036] [025/132] (828s left) core_sysfs (read-all-entries)
[190.656086] Starting subtest: read-all-entries
[190.665637] Subtest read-all-entries: SUCCESS (0.010s)
[190.810431] [026/132] (828s left) i915_drm_fdinfo (virtual-busy-hang-all)
[190.854984] Starting subtest: virtual-busy-hang-all
[190.859607] Subtest virtual-busy-hang-all: SKIP (0.000s)
[190.940161] [027/132] (827s left) gem_pxp (fail-invalid-protected-context)
[191.063091] Starting subtest: fail-invalid-protected-context
[191.065593] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[191.210208] [028/132] (827s left) kms_color (invalid-degamma-lut-sizes)
[191.312118] Starting subtest: invalid-degamma-lut-sizes
[191.314049] Starting dynamic subtest: pipe-A
[191.605458] Dynamic subtest pipe-A: SUCCESS (0.293s)
[191.614350] Starting dynamic subtest: pipe-B
[191.616766] Dynamic subtest pipe-B: SUCCESS (0.001s)
[191.624594] Starting dynamic subtest: pipe-C
[191.626968] Dynamic subtest pipe-C: SUCCESS (0.001s)
[191.634710] Starting dynamic subtest: pipe-D
[191.637090] Dynamic subtest pipe-D: SUCCESS (0.001s)
[191.639015] Subtest invalid-degamma-lut-sizes: SUCCESS (0.297s)
[192.416350] [029/132] (826s left) gem_create (create-ext-cpu-access-big)
[192.585947] Starting subtest: create-ext-cpu-access-big
[192.591140] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[192.685496] [030/132] (826s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[192.782243] Starting subtest: fbc-rgb101010-draw-pwrite
[198.164864] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.384s)
[199.361525] [031/132] (819s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[199.472157] Starting subtest: x-tiled-8bpp-rotate-270
[199.492725] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[199.640146] [032/132] (819s left) gem_softpin (safe-alignment)
[199.705067] Starting subtest: safe-alignment
[199.726034] Subtest safe-alignment: SUCCESS (0.021s)
[200.984198] [033/132] (818s left) gem_exec_schedule (semaphore-codependency)
[201.064163] Starting subtest: semaphore-codependency
[201.070086] Subtest semaphore-codependency: SUCCESS (0.013s)
[201.459655] [034/132] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[201.559410] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[201.563430] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[201.711168] [035/132] (817s left) kms_sequence (queue-idle)
[201.824231] Starting subtest: queue-idle
[201.826596] Starting dynamic subtest: pipe-A-eDP-1
[203.599446] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.777s)
[203.608611] Starting dynamic subtest: pipe-B-eDP-1
[206.085093] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.483s)
[206.094220] Starting dynamic subtest: pipe-C-eDP-1
[208.564517] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.479s)
[208.573229] Starting dynamic subtest: pipe-D-eDP-1
[210.980469] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[210.982889] Subtest queue-idle: SUCCESS (9.159s)
[211.828252] [036/132] (807s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[211.918239] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[211.920594] Starting dynamic subtest: pipe-A-default-mode
[212.209157] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[212.213988] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.290s)
[213.050588] [037/132] (806s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[213.159994] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[213.164338] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[213.285587] [038/132] (806s left) kms_flip (flip-vs-expired-vblank-interruptible)
[213.381334] Starting subtest: flip-vs-expired-vblank-interruptible
[213.383618] Starting dynamic subtest: A-eDP1
[222.019882] Dynamic subtest A-eDP1: SUCCESS (8.637s)
[222.027970] Starting dynamic subtest: B-eDP1
[230.651245] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[230.658947] Starting dynamic subtest: C-eDP1
[239.275954] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[239.283574] Starting dynamic subtest: D-eDP1
[247.911775] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[247.916730] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.533s)
[249.111493] [039/132] (770s left) gem_ctx_persistence (smoketest)
[249.191136] Starting subtest: smoketest
[289.844320] Subtest smoketest: SUCCESS (40.650s)
[289.951837] [040/132] (729s left) kms_cursor_crc (cursor-onscreen-256x85)
[290.216862] Starting subtest: cursor-onscreen-256x85
[290.267620] Subtest cursor-onscreen-256x85: SKIP (0.046s)
[290.459570] [041/132] (729s left) gem_flink_basic (double-flink)
[290.525325] Starting subtest: double-flink
[290.528096] Subtest double-flink: SUCCESS (0.000s)
[290.655059] [042/132] (728s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[290.752955] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[297.490594] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.741s)
[297.619635] [043/132] (722s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[297.733412] Starting subtest: extended-modeset-hang-oldfb-with-reset
[297.735984] Starting dynamic subtest: pipe-A
[309.711693] Dynamic subtest pipe-A: SUCCESS (11.977s)
[309.721216] Starting dynamic subtest: pipe-D
[321.967525] Dynamic subtest pipe-D: SUCCESS (12.251s)
[321.969930] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.232s)
[322.790051] [044/132] (696s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[322.895277] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[322.897157] Starting dynamic subtest: pipe-A-eDP-1
[325.015708] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s)
[325.025826] Starting dynamic subtest: pipe-B-eDP-1
[327.172034] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.155s)
[327.180058] Starting dynamic subtest: pipe-C-eDP-1
[329.264428] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.091s)
[329.272723] Starting dynamic subtest: pipe-D-eDP-1
[331.241598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.976s)
[331.243936] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.348s)
[332.522900] [045/132] (687s left) i915_selftest (live)
[336.015201] Starting subtest: live
[336.017617] Starting dynamic subtest: sanitycheck
[340.459852] Dynamic subtest sanitycheck: SUCCESS (4.448s)
[340.468812] Starting dynamic subtest: uncore
[344.862495] Dynamic subtest uncore: SUCCESS (4.400s)
[344.871939] Starting dynamic subtest: workarounds
[348.172061] Dynamic subtest workarounds: SUCCESS (3.308s)
[348.181488] Starting dynamic subtest: gt_engines
[352.831283] Dynamic subtest gt_engines: SUCCESS (4.657s)
[352.840565] Starting dynamic subtest: gt_timelines
[368.301496] Dynamic subtest gt_timelines: SUCCESS (15.467s)
[368.311239] Starting dynamic subtest: gt_contexts
[372.761255] Dynamic subtest gt_contexts: SUCCESS (4.458s)
[372.768321] Starting dynamic subtest: gt_lrc
[377.217367] Dynamic subtest gt_lrc: SUCCESS (4.453s)
[377.226324] Starting dynamic subtest: gt_mocs
[380.312333] Dynamic subtest gt_mocs: SUCCESS (3.092s)
[380.321063] Starting dynamic subtest: gt_pm
[387.236334] Dynamic subtest gt_pm: SUCCESS (6.922s)
[387.250817] Starting dynamic subtest: gt_heartbeat
[391.680823] Dynamic subtest gt_heartbeat: SUCCESS (4.441s)
[391.690065] Starting dynamic subtest: gt_tlb
[401.132989] Dynamic subtest gt_tlb: SUCCESS (9.450s)
[401.146947] Starting dynamic subtest: requests
[414.730900] Dynamic subtest requests: SUCCESS (13.595s)
[414.743763] Starting dynamic subtest: migrate
[420.857415] Dynamic subtest migrate: SUCCESS (6.111s)
[420.866243] Starting dynamic subtest: active
[425.299267] Dynamic subtest active: SUCCESS (4.454s)
[425.308040] Starting dynamic subtest: objects
[430.250844] Dynamic subtest objects: SUCCESS (4.951s)
[430.260057] Starting dynamic subtest: mman
[435.069383] Dynamic subtest mman: SUCCESS (4.815s)
[435.078490] Starting dynamic subtest: dmabuf
[439.525577] Dynamic subtest dmabuf: SUCCESS (4.455s)
[439.534701] Starting dynamic subtest: vma
[443.971851] Dynamic subtest vma: SUCCESS (4.444s)
[443.980794] Starting dynamic subtest: coherency
[449.169884] Dynamic subtest coherency: SUCCESS (5.196s)
[449.178871] Starting dynamic subtest: gtt
[459.253470] Dynamic subtest gtt: SUCCESS (10.081s)
[459.262631] Starting dynamic subtest: gem
[465.852056] Dynamic subtest gem: SUCCESS (6.584s)
[465.861284] Starting dynamic subtest: evict
[469.878778] Dynamic subtest evict: SUCCESS (4.038s)
[469.887811] Starting dynamic subtest: hugepages
[478.964326] Dynamic subtest hugepages: SUCCESS (9.083s)
[478.973894] Starting dynamic subtest: gem_contexts
[505.814533] Dynamic subtest gem_contexts: SUCCESS (26.847s)
[505.823254] Starting dynamic subtest: client
[508.750999] Dynamic subtest client: SUCCESS (2.934s)
[508.760399] Starting dynamic subtest: gem_migrate
[513.222577] Dynamic subtest gem_migrate: SUCCESS (4.470s)
[513.231976] Starting dynamic subtest: reset
[516.089632] Dynamic subtest reset: SUCCESS (2.864s)
[516.098722] Starting dynamic subtest: memory_region
[520.520572] Dynamic subtest memory_region: SUCCESS (4.429s)
[520.529998] Starting dynamic subtest: hangcheck
[533.699075] Dynamic subtest hangcheck: SUCCESS (13.175s)
[533.707987] Starting dynamic subtest: execlists
[538.196665] Dynamic subtest execlists: SUCCESS (4.495s)
[538.206358] Starting dynamic subtest: ring_submission
[542.690584] Dynamic subtest ring_submission: SUCCESS (4.492s)
[542.699675] Starting dynamic subtest: perf
[547.341440] Dynamic subtest perf: SUCCESS (4.648s)
[547.350560] Starting dynamic subtest: slpc
[561.517266] Dynamic subtest slpc: SUCCESS (14.173s)
[561.526139] Starting dynamic subtest: guc
[565.538710] Dynamic subtest guc: SUCCESS (4.019s)
[565.547848] Starting dynamic subtest: guc_multi_lrc
[568.330375] Dynamic subtest guc_multi_lrc: SUCCESS (2.789s)
[568.339876] Starting dynamic subtest: guc_hang
[573.361224] Dynamic subtest guc_hang: SUCCESS (5.029s)
[573.370509] Starting dynamic subtest: late_gt_pm
[577.829081] Dynamic subtest late_gt_pm: SUCCESS (4.465s)
[577.831986] Subtest live: SUCCESS (241.809s)
[577.866973] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[577.867791] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[577.871112] [046/132] (441s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[579.451783] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[579.456070] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[579.554913] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[579.556219] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[579.559681] [047/132] (440s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[579.664528] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[579.668900] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[579.800411] [048/132] (440s left) perf (polling)
[579.929403] Starting subtest: polling
[579.931767] Starting dynamic subtest: 0-rcs0
[589.955170] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[589.966831] Starting dynamic subtest: 1-vcs0
[599.975783] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[599.978317] Subtest polling: SUCCESS (20.047s)
[600.023863] [049/132] (419s left) kms_flip (plain-flip-fb-recreate)
[600.122014] Starting subtest: plain-flip-fb-recreate
[600.124194] Starting dynamic subtest: A-eDP1
[608.955871] Dynamic subtest A-eDP1: SUCCESS (8.835s)
[608.969788] Starting dynamic subtest: B-eDP1
[617.788061] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[617.801430] Starting dynamic subtest: C-eDP1
[626.617924] Dynamic subtest C-eDP1: SUCCESS (8.828s)
[626.627413] Starting dynamic subtest: D-eDP1
[635.445155] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[635.447186] Subtest plain-flip-fb-recreate: SUCCESS (35.328s)
[636.643638] [050/132] (383s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[636.779823] Starting subtest: cursor-vs-flip-atomic-transitions
[666.595987] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.814s)
[667.467773] [051/132] (352s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[667.572752] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[671.740929] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.171s)
[672.891500] [052/132] (347s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[672.995799] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[673.000101] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[673.131608] [053/132] (346s left) gem_flink_basic (flink-lifetime)
[673.189662] Starting subtest: flink-lifetime
[673.192124] Subtest flink-lifetime: SUCCESS (0.002s)
[673.305359] [054/132] (346s left) gem_exec_reloc (basic-cpu-read-noreloc)
[673.364038] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[673.435977] [055/132] (346s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[673.488761] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[673.491039] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[673.619538] [056/132] (346s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[673.679839] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[673.684380] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[673.884832] [057/132] (346s left) kms_mmap_write_crc (main)
[673.994163] Starting subtest: main
[673.996475] Starting dynamic subtest: pipe-A-eDP-1
[677.409089] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.412s)
[677.411490] Subtest main: SUCCESS (3.414s)
[678.306178] [058/132] (341s left) gem_exec_whisper (basic-queues-all)
[678.374571] Starting subtest: basic-queues-all
[689.357340] Subtest basic-queues-all: SUCCESS (10.980s)
[689.566310] [059/132] (330s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[689.666675] Starting subtest: fbc-pr-sprite-mmap-cpu
[689.670718] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[689.760404] [060/132] (330s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[689.884302] Starting subtest: flip-vs-cursor-atomic
[696.889542] Subtest flip-vs-cursor-atomic: SUCCESS (7.004s)
[697.730510] [061/132] (322s left) api_intel_bb (simple-bb)
[697.793875] Starting subtest: simple-bb
[697.801833] Subtest simple-bb: SUCCESS (0.008s)
[697.940780] [062/132] (322s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[698.001211] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[698.072797] [063/132] (322s left) kms_invalid_mode (bad-vsync-end)
[698.154854] Starting subtest: bad-vsync-end
[698.157044] Starting dynamic subtest: pipe-A-eDP-1
[698.447243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[698.455548] Starting dynamic subtest: pipe-B-eDP-1
[698.457437] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[698.464660] Starting dynamic subtest: pipe-C-eDP-1
[698.466646] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[698.474133] Starting dynamic subtest: pipe-D-eDP-1
[698.476260] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[698.478417] Subtest bad-vsync-end: SUCCESS (0.297s)
[699.268534] [064/132] (321s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[699.328986] Starting subtest: framebuffer-vs-set-tiling
[699.333459] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[699.490256] [065/132] (321s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[699.585282] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[699.587618] Starting dynamic subtest: pipe-A-default-mode
[700.711170] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[700.715598] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.126s)
[700.871451] [066/132] (319s left) gem_lmem_swapping (verify-ccs)
[700.926119] Subtest verify-ccs: SKIP (0.000s)
[700.976416] [067/132] (319s left) vgem_basic (bad-flag)
[701.016290] Starting subtest: bad-flag
[701.018392] Subtest bad-flag: SUCCESS (0.000s)
[701.093532] [068/132] (319s left) kms_big_fb (linear-32bpp-rotate-180)
[701.201919] Starting subtest: linear-32bpp-rotate-180
[702.780906] Subtest linear-32bpp-rotate-180: SUCCESS (1.579s)
[702.938696] [069/132] (317s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[703.005655] Subtest writes-after-reads: SKIP (0.000s)
[703.080334] [070/132] (317s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[703.180200] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[703.183657] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[703.318353] [071/132] (317s left) gem_ctx_bad_destroy (double-destroy)
[703.380257] Starting subtest: double-destroy
[703.382403] Subtest double-destroy: SUCCESS (0.000s)
[703.477436] [072/132] (317s left) kms_chamelium_color (ctm-blue-to-red)
[703.562837] Subtest ctm-blue-to-red: SKIP (0.000s)
[703.605146] [073/132] (317s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[703.699244] Starting subtest: fbc-psr-cursor-mmap-cpu
[703.701130] Starting dynamic subtest: eDP-1
[703.704576] Dynamic subtest eDP-1: SKIP (0.000s)
[703.708092] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[703.820195] [074/132] (317s left) i915_drm_fdinfo (isolation)
[703.863825] Starting subtest: isolation
[703.865629] Starting dynamic subtest: rcs0
[703.888927] Dynamic subtest rcs0: SKIP (0.024s)
[703.899982] Starting dynamic subtest: bcs0
[703.903545] Dynamic subtest bcs0: SKIP (0.000s)
[703.913422] Starting dynamic subtest: vcs0
[703.916974] Dynamic subtest vcs0: SKIP (0.000s)
[703.924294] Starting dynamic subtest: vcs1
[703.927725] Dynamic subtest vcs1: SKIP (0.001s)
[703.934590] Starting dynamic subtest: vecs0
[703.938018] Dynamic subtest vecs0: SKIP (0.000s)
[703.945120] Starting dynamic subtest: ccs0
[703.948515] Dynamic subtest ccs0: SKIP (0.000s)
[703.951931] Subtest isolation: SKIP (0.032s)
[703.988506] [075/132] (316s left) gem_ctx_sseu (invalid-args)
[704.044903] Subtest invalid-args: SKIP (0.000s)
[704.117454] [076/132] (316s left) gen9_exec_parse (allowed-all)
[704.180947] Subtest allowed-all: SKIP (0.000s)
[704.256447] [077/132] (316s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[709.272553] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[709.274474] Starting dynamic subtest: pipe-A-eDP-1
[716.167891] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.895s)
[716.181186] Starting dynamic subtest: pipe-B-eDP-1
[723.079159] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.793s)
[723.081949] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.693s)
[723.846886] [078/132] (297s left) kms_chamelium_frames (dp-crc-multiple)
[724.244916] Subtest dp-crc-multiple: SKIP (0.000s)
[725.037105] [079/132] (296s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[725.130897] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[725.133393] Starting dynamic subtest: pipe-A
[725.151018] Dynamic subtest pipe-A: SKIP (0.015s)
[725.162085] Starting dynamic subtest: pipe-B
[725.178078] Dynamic subtest pipe-B: SKIP (0.027s)
[725.186528] Starting dynamic subtest: pipe-C
[725.204134] Dynamic subtest pipe-C: SKIP (0.027s)
[725.212887] Starting dynamic subtest: pipe-D
[725.232450] Dynamic subtest pipe-D: SKIP (0.027s)
[725.236904] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.099s)
[725.370240] [080/132] (295s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[725.466031] Starting subtest: y-tiled-8bpp-rotate-270
[725.470461] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[725.595033] [081/132] (295s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[725.690784] Starting subtest: psr-rgb565-draw-blt
[732.734692] Subtest psr-rgb565-draw-blt: SUCCESS (7.047s)
[732.917119] [082/132] (288s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[733.057845] Starting subtest: cursorB-vs-flipA-atomic-transitions
[733.062477] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[733.221160] [083/132] (287s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[733.318319] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[740.126248] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.810s)
[740.307651] [084/132] (280s left) kms_big_fb (4-tiled-addfb)
[740.415066] Starting subtest: 4-tiled-addfb
[740.417238] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[740.547657] [085/132] (280s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[740.938867] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[741.773754] [086/132] (279s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[741.881775] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[741.886147] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[742.014679] [087/132] (279s left) gem_mmap_gtt (big-bo-tiledy)
[742.079349] Subtest big-bo-tiledY: SKIP (0.000s)
[742.150972] [088/132] (279s left) gem_ctx_persistence (engines-hang)
[742.217291] Starting subtest: engines-hang
[742.219557] Starting dynamic subtest: rcs0
[742.354538] Dynamic subtest rcs0: SUCCESS (0.139s)
[742.366320] Starting dynamic subtest: bcs0
[742.472440] Dynamic subtest bcs0: SUCCESS (0.115s)
[742.483911] Starting dynamic subtest: vcs0
[742.582335] Dynamic subtest vcs0: SUCCESS (0.108s)
[742.593421] Starting dynamic subtest: vcs1
[742.701264] Dynamic subtest vcs1: SUCCESS (0.118s)
[742.714747] Starting dynamic subtest: vecs0
[742.819561] Dynamic subtest vecs0: SUCCESS (0.116s)
[742.830034] Starting dynamic subtest: ccs0
[742.931540] Dynamic subtest ccs0: SUCCESS (0.110s)
[742.933922] Subtest engines-hang: SUCCESS (0.718s)
[743.038196] [089/132] (278s left) prime_self_import (export-vs-gem_close-race)
[743.073521] Starting subtest: export-vs-gem_close-race
[748.191527] Subtest export-vs-gem_close-race: SUCCESS (5.118s)
[748.296895] [090/132] (273s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[748.403923] Starting subtest: 4-tiled-16bpp-rotate-0
[749.605838] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.201s)
[749.751588] [091/132] (271s left) drm_read (short-buffer-block)
[749.903064] Starting subtest: short-buffer-block
[749.905236] Subtest short-buffer-block: SUCCESS (0.000s)
[750.068051] [092/132] (271s left) sriov_basic (bind-unbind-vf)
[750.132351] Starting subtest: bind-unbind-vf
[750.134634] Starting dynamic subtest: vf-1
[750.202666] Dynamic subtest vf-1: FAIL (0.024s)
[750.211898] Starting dynamic subtest: vf-2
[750.273188] Dynamic subtest vf-2: FAIL (0.003s)
[750.283065] Starting dynamic subtest: vf-3
[750.343441] Dynamic subtest vf-3: FAIL (0.003s)
[750.352588] Starting dynamic subtest: vf-4
[750.412085] Dynamic subtest vf-4: FAIL (0.003s)
[750.420757] Starting dynamic subtest: vf-5
[750.482350] Dynamic subtest vf-5: FAIL (0.003s)
[750.491539] Starting dynamic subtest: vf-6
[750.551960] Dynamic subtest vf-6: FAIL (0.004s)
[750.560900] Starting dynamic subtest: vf-7
[750.622126] Dynamic subtest vf-7: FAIL (0.003s)
[750.629598] Starting dynamic subtest: vf-random
[750.689621] Dynamic subtest vf-random: FAIL (0.003s)
[750.696946] Starting dynamic subtest: vf-last
[750.764785] Dynamic subtest vf-last: FAIL (0.429s)
[750.766400] Subtest bind-unbind-vf: FAIL (0.485s)
[750.801060] [093/132] (270s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[750.866125] Starting subtest: multi-wait-all-available-submitted-signaled
[750.867910] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[750.984589] [094/132] (270s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[751.100127] Starting subtest: cursor-tearing-framebuffer-change
[751.101925] Starting dynamic subtest: pipe-A-eDP-1
[751.672265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[751.680915] Starting dynamic subtest: pipe-D-eDP-1
[752.921478] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[752.923872] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.821s)
[753.786195] [095/132] (267s left) gem_mmap_wc (write-wc-read-gtt)
[753.850240] Subtest write-wc-read-gtt: SKIP (0.000s)
[753.907772] [096/132] (267s left) kms_flip (bo-too-big-interruptible)
[754.004279] Starting subtest: bo-too-big-interruptible
[754.006539] Starting dynamic subtest: A-eDP1
[755.317383] Dynamic subtest A-eDP1: SUCCESS (1.312s)
[755.327792] Starting dynamic subtest: B-eDP1
[756.548044] Dynamic subtest B-eDP1: SUCCESS (1.230s)
[756.556751] Starting dynamic subtest: C-eDP1
[757.793636] Dynamic subtest C-eDP1: SUCCESS (1.245s)
[757.807186] Starting dynamic subtest: D-eDP1
[759.044162] Dynamic subtest D-eDP1: SUCCESS (1.247s)
[759.049215] Subtest bo-too-big-interruptible: SUCCESS (5.044s)
[760.261329] [097/132] (261s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[760.360553] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[764.778786] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.422s)
[765.936833] [098/132] (255s left) gem_mmap_gtt (ptrace)
[765.995329] Subtest ptrace: SKIP (0.000s)
[766.062259] [099/132] (255s left) gem_exec_gttfill (engines)
[766.114805] Starting subtest: engines
[766.117069] Starting dynamic subtest: rcs0
[789.042362] Dynamic subtest rcs0: SUCCESS (22.925s)
[789.054621] Starting dynamic subtest: bcs0
[812.377583] Dynamic subtest bcs0: SUCCESS (23.332s)
[812.386117] Starting dynamic subtest: vcs0
[835.625971] Dynamic subtest vcs0: SUCCESS (23.245s)
[835.637247] Starting dynamic subtest: vcs1
[858.890457] Dynamic subtest vcs1: SUCCESS (23.261s)
[858.899567] Starting dynamic subtest: vecs0
[882.186041] Dynamic subtest vecs0: SUCCESS (23.290s)
[882.202777] Starting dynamic subtest: ccs0
[905.429628] Dynamic subtest ccs0: SUCCESS (23.241s)
[905.432073] Subtest engines: SUCCESS (139.310s)
[905.645448] [100/132] (116s left) gem_ppgtt (blt-vs-render-ctx0)
[905.753251] Starting subtest: blt-vs-render-ctx0
[938.640370] Subtest blt-vs-render-ctx0: SUCCESS (32.886s)
[938.813600] [101/132] ( 83s left) dumb_buffer (map-valid)
[938.895659] Starting subtest: map-valid
[938.897926] Subtest map-valid: SUCCESS (0.000s)
[939.044701] [102/132] ( 82s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[939.151610] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[939.156110] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[939.286376] [103/132] ( 82s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[939.386069] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[939.390292] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[939.523508] [104/132] ( 82s left) prime_busy (after)
[939.604439] Starting subtest: after
[939.609775] Starting dynamic subtest: rcs0
[939.672357] Dynamic subtest rcs0: SUCCESS (0.063s)
[939.683063] Starting dynamic subtest: bcs0
[939.737614] Dynamic subtest bcs0: SUCCESS (0.064s)
[939.746605] Starting dynamic subtest: vcs0
[939.777707] Dynamic subtest vcs0: SUCCESS (0.039s)
[939.785948] Starting dynamic subtest: vcs1
[939.817579] Dynamic subtest vcs1: SUCCESS (0.039s)
[939.825936] Starting dynamic subtest: vecs0
[939.857177] Dynamic subtest vecs0: SUCCESS (0.039s)
[939.865460] Starting dynamic subtest: ccs0
[939.897089] Dynamic subtest ccs0: SUCCESS (0.039s)
[940.006705] Subtest after: SUCCESS (0.403s)
[940.102309] [105/132] ( 82s left) gem_exec_store (cachelines)
[940.172996] Starting subtest: cachelines
[940.175535] Starting dynamic subtest: rcs0
[940.284690] Dynamic subtest rcs0: SUCCESS (0.111s)
[940.297733] Starting dynamic subtest: bcs0
[940.352283] Dynamic subtest bcs0: SUCCESS (0.064s)
[940.363581] Starting dynamic subtest: vcs0
[940.415849] Dynamic subtest vcs0: SUCCESS (0.062s)
[940.426430] Starting dynamic subtest: vcs1
[940.479107] Dynamic subtest vcs1: SUCCESS (0.061s)
[940.490156] Starting dynamic subtest: vecs0
[940.537505] Dynamic subtest vecs0: SUCCESS (0.056s)
[940.548055] Starting dynamic subtest: ccs0
[940.601385] Dynamic subtest ccs0: SUCCESS (0.062s)
[940.603814] Subtest cachelines: SUCCESS (0.429s)
[940.816572] [106/132] ( 81s left) gem_exec_reloc (basic-wc)
[940.881086] Subtest basic-wc: SKIP (0.000s)
[940.952310] [107/132] ( 81s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[941.011431] Starting subtest: multi-wait-for-submit-submitted-signaled
[941.013365] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[941.158516] [108/132] ( 81s left) kms_hdr (bpc-switch-suspend)
[941.251141] Starting subtest: bpc-switch-suspend
[942.364059] Starting dynamic subtest: pipe-A-eDP-1
[962.179418] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.352s)
[962.181779] Subtest bpc-switch-suspend: SUCCESS (9.466s)
[962.337311] [109/132] ( 59s left) kms_pm_dc (dc5-dpms)
[963.466975] Starting subtest: dc5-dpms
[965.517681] Subtest dc5-dpms: SUCCESS (2.050s)
[965.622741] [110/132] ( 56s left) api_intel_allocator (execbuf-with-allocator)
[965.680398] Starting subtest: execbuf-with-allocator
[965.685269] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[965.813857] [111/132] ( 56s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[965.933603] Starting subtest: fbcpsr-stridechange
[972.110405] Subtest fbcpsr-stridechange: SUCCESS (6.178s)
[972.294744] [112/132] ( 50s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[972.399689] Starting subtest: yf-tiled-32bpp-rotate-90
[972.403823] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[972.510474] [113/132] ( 49s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[972.604819] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[972.608951] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[972.730489] [114/132] ( 49s left) gem_exec_balancer (parallel-keep-submit-fence)
[972.993515] Starting subtest: parallel-keep-submit-fence
[974.084276] Subtest parallel-keep-submit-fence: SUCCESS (1.090s)
[974.224064] [115/132] ( 48s left) kms_cursor_crc (cursor-size-change)
[974.316466] Starting subtest: cursor-size-change
[974.318792] Starting dynamic subtest: pipe-A-eDP-1
[975.115304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[975.125352] Starting dynamic subtest: pipe-D-eDP-1
[976.664828] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.549s)
[976.666748] Subtest cursor-size-change: SUCCESS (2.348s)
[977.505686] [116/132] ( 45s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[977.568882] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[977.571171] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[977.702208] [117/132] ( 44s left) gem_exec_reloc (basic-write-gtt-active)
[977.774926] Subtest basic-write-gtt-active: SKIP (0.000s)
[977.877988] [118/132] ( 44s left) syncobj_basic (test-valid-cycle)
[977.932007] Starting subtest: test-valid-cycle
[977.934318] Subtest test-valid-cycle: SUCCESS (0.000s)
[978.041151] [119/132] ( 44s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[978.137252] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[978.139610] Starting dynamic subtest: pipe-A-eDP-1
[978.148613] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[978.158818] Starting dynamic subtest: pipe-B-eDP-1
[978.167739] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[978.177484] Starting dynamic subtest: pipe-C-eDP-1
[978.186091] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[978.194891] Starting dynamic subtest: pipe-D-eDP-1
[978.203520] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[978.207831] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[980.463978] [120/132] ( 42s left) gem_unfence_active_buffers
[980.639614] [121/132] ( 42s left) kms_universal_plane (disable-primary-vs-flip)
[980.726228] Starting subtest: disable-primary-vs-flip
[980.728553] Starting dynamic subtest: pipe-A-eDP-1
[982.355661] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.629s)
[982.365574] Starting dynamic subtest: pipe-B-eDP-1
[984.586481] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.229s)
[984.598211] Starting dynamic subtest: pipe-C-eDP-1
[986.732365] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.144s)
[986.743720] Starting dynamic subtest: pipe-D-eDP-1
[988.922840] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.187s)
[988.924804] Subtest disable-primary-vs-flip: SUCCESS (8.194s)
[989.735584] [122/132] ( 33s left) kms_addfb_basic (invalid-set-prop)
[989.797136] Starting subtest: invalid-set-prop
[989.799488] Subtest invalid-set-prop: SUCCESS (0.000s)
[989.972241] [123/132] ( 32s left) kms_psr (pr-primary-mmap-gtt)
[990.079932] Starting subtest: pr-primary-mmap-gtt
[990.084038] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[990.179291] [124/132] ( 32s left) kms_cursor_legacy (torture-move)
[990.305565] Starting subtest: torture-move
[990.307907] Starting dynamic subtest: pipe-A
[996.242581] Dynamic subtest pipe-A: SUCCESS (5.933s)
[996.255607] Starting dynamic subtest: pipe-B
[1002.186013] Dynamic subtest pipe-B: SUCCESS (5.941s)
[1002.199995] Starting dynamic subtest: pipe-C
[1008.200399] Dynamic subtest pipe-C: SUCCESS (6.011s)
[1008.210096] Starting dynamic subtest: pipe-D
[1013.914229] Dynamic subtest pipe-D: SUCCESS (5.711s)
[1013.929145] Starting dynamic subtest: all-pipes
[1020.189660] Dynamic subtest all-pipes: SUCCESS (6.273s)
[1020.192078] Subtest torture-move: SUCCESS (29.881s)
[1020.376229] [125/132] (  2s left) i915_pm_rpm (debugfs-forcewake-user)
[1022.508209] Starting subtest: debugfs-forcewake-user
[1033.908393] Subtest debugfs-forcewake-user: SUCCESS (11.400s)
[1034.304190] Overall timeout time exceeded, stopping.
[1034.319149] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_plane_multiple
results: parsing output: 7/ for test: gem_wait
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_prop_blob
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: core_sysfs
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: gem_pxp
results: parsing output: 27/ for test: kms_color
results: parsing output: 28/ for test: gem_create
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_softpin
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_sequence
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_busy
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: i915_selftest
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_flink_basic
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_mmap_write_crc
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: api_intel_bb
results: parsing output: 61/ for test: kms_pipe_b_c_ivb
results: parsing output: 62/ for test: kms_invalid_mode
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ctx_bad_destroy
results: parsing output: 71/ for test: kms_chamelium_color
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: i915_drm_fdinfo
results: parsing output: 74/ for test: gem_ctx_sseu
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_chamelium_hpd
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: prime_self_import
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: drm_read
results: parsing output: 91/ for test: sriov_basic
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_exec_gttfill
results: parsing output: 99/ for test: gem_ppgtt
results: parsing output: 100/ for test: dumb_buffer
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: prime_busy
results: parsing output: 104/ for test: gem_exec_store
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_hdr
results: parsing output: 108/ for test: kms_pm_dc
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: syncobj_basic
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_unfence_active_buffers
results: parsing output: 120/ for test: kms_universal_plane
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 126/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 127/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 128/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 129/ for test: kms_content_protection
results: no output, setting notrun
results: parsing output: 130/ for test: kms_plane_alpha_blend
results: no output, setting notrun
results: parsing output: 131/ for test: kms_addfb_basic
results: no output, setting notrun
Done.