[57.686493] Initializing watchdogs
[57.686565]   /dev/watchdog0
[57.700257] [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.704887] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.707271] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.710409] [001/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[57.831399] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[61.523914] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.680s)
[62.743851] [002/132] (955s left) kms_pm_rpm (modeset-lpsp-stress)
[64.290045] Starting subtest: modeset-lpsp-stress
[80.081274] Subtest modeset-lpsp-stress: SUCCESS (15.774s)
[80.193356] [003/132] (938s left) kms_plane_scaling (2x-scaler-multi-pipe)
[80.292758] Starting subtest: 2x-scaler-multi-pipe
[80.297151] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[80.418303] [004/132] (937s left) kms_cursor_crc (cursor-sliding-256x256)
[80.650215] Starting subtest: cursor-sliding-256x256
[80.654830] Starting dynamic subtest: pipe-A-eDP-1
[83.859322] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.203s)
[83.894159] Starting dynamic subtest: pipe-D-eDP-1
[87.727339] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.839s)
[87.729678] Subtest cursor-sliding-256x256: SUCCESS (7.074s)
[88.624174] [005/132] (929s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[88.741807] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[88.746361] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[88.871974] [006/132] (929s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[88.971392] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[88.973426] Starting dynamic subtest: pipe-A-eDP-1
[89.119366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[89.128731] Starting dynamic subtest: pipe-B-eDP-1
[89.148658] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[89.155532] Starting dynamic subtest: pipe-C-eDP-1
[89.175021] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[89.181709] Starting dynamic subtest: pipe-D-eDP-1
[89.201234] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[89.203118] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.147s)
[91.380268] [007/132] (927s left) kms_plane_multiple (tiling-4)
[91.472459] Starting subtest: tiling-4
[91.474390] Starting dynamic subtest: pipe-A-eDP-1
[95.233639] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.760s)
[95.248261] Starting dynamic subtest: pipe-B-eDP-1
[99.616255] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.380s)
[99.624500] Starting dynamic subtest: pipe-C-eDP-1
[103.927340] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.309s)
[103.935617] Starting dynamic subtest: pipe-D-eDP-1
[108.225924] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.297s)
[108.228348] Subtest tiling-4: SUCCESS (16.750s)
[109.058777] [008/132] (909s left) gem_wait (write-busy)
[109.123732] Starting subtest: write-busy
[109.125821] Starting dynamic subtest: all-engines
[109.758262] Dynamic subtest all-engines: SUCCESS (0.638s)
[109.772965] Starting dynamic subtest: rcs0
[110.308447] Dynamic subtest rcs0: SUCCESS (0.549s)
[110.322172] Starting dynamic subtest: bcs0
[110.854483] Dynamic subtest bcs0: SUCCESS (0.545s)
[110.868618] Starting dynamic subtest: vcs0
[112.922274] Dynamic subtest vcs0: SUCCESS (2.065s)
[112.936477] Starting dynamic subtest: vcs1
[114.903797] Dynamic subtest vcs1: SUCCESS (1.980s)
[114.917448] Starting dynamic subtest: vecs0
[116.915829] Dynamic subtest vecs0: SUCCESS (1.982s)
[116.925655] Starting dynamic subtest: ccs0
[117.437438] Dynamic subtest ccs0: SUCCESS (0.550s)
[117.439988] Subtest write-busy: SUCCESS (8.316s)
[117.659204] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[117.662845] [009/132] (900s left) perf_pmu (init-busy)
[117.707320] Starting subtest: init-busy
[117.709634] Starting dynamic subtest: rcs0
[117.711855] Dynamic subtest rcs0: SUCCESS (0.001s)
[117.721050] Starting dynamic subtest: bcs0
[117.723203] Dynamic subtest bcs0: SUCCESS (0.000s)
[117.730282] Starting dynamic subtest: vcs0
[117.732430] Dynamic subtest vcs0: SUCCESS (0.001s)
[117.739512] Starting dynamic subtest: vcs1
[117.741707] Dynamic subtest vcs1: SUCCESS (0.001s)
[117.748636] Starting dynamic subtest: vecs0
[117.750515] Dynamic subtest vecs0: SUCCESS (0.000s)
[117.757172] Starting dynamic subtest: ccs0
[117.759715] Dynamic subtest ccs0: SUCCESS (0.000s)
[117.761976] Subtest init-busy: SUCCESS (0.006s)
[117.840866] [010/132] (900s left) syncobj_timeline (signal-point-0)
[117.895745] Starting subtest: signal-point-0
[117.898085] Subtest signal-point-0: SUCCESS (0.000s)
[118.017802] [011/132] (900s left) perf (invalid-remove-userspace-config)
[118.152407] Starting subtest: invalid-remove-userspace-config
[118.160289] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[118.202683] [012/132] (900s left) kms_vrr (flip-basic-fastset)
[118.307022] Starting subtest: flip-basic-fastset
[118.313367] Subtest flip-basic-fastset: SKIP (0.000s)
[118.403700] [013/132] (900s left) kms_psr (psr-sprite-blt)
[118.511805] Starting subtest: psr-sprite-blt
[118.514075] Starting dynamic subtest: eDP-1
[120.260373] Dynamic subtest eDP-1: SUCCESS (1.747s)
[120.262695] Subtest psr-sprite-blt: SUCCESS (1.748s)
[121.123919] [014/132] (897s left) gem_exec_schedule (pi-common)
[121.327634] Starting subtest: pi-common
[121.329797] Starting dynamic subtest: rcs0
[121.350876] Dynamic subtest rcs0: SUCCESS (0.026s)
[121.363530] Starting dynamic subtest: bcs0
[121.376935] Dynamic subtest bcs0: SUCCESS (0.026s)
[121.388823] Starting dynamic subtest: vcs0
[121.402050] Dynamic subtest vcs0: SUCCESS (0.025s)
[121.412152] Starting dynamic subtest: vcs1
[121.428213] Dynamic subtest vcs1: SUCCESS (0.026s)
[121.439978] Starting dynamic subtest: vecs0
[121.454399] Dynamic subtest vecs0: SUCCESS (0.026s)
[121.466620] Starting dynamic subtest: ccs0
[121.480379] Dynamic subtest ccs0: SUCCESS (0.025s)
[121.482689] Subtest pi-common: SUCCESS (0.156s)
[121.725303] [015/132] (897s left) kms_prop_blob (blob-prop-validate)
[121.793563] Starting subtest: blob-prop-validate
[121.795889] Subtest blob-prop-validate: SUCCESS (0.000s)
[121.927764] [016/132] (896s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[122.030604] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[126.594082] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.567s)
[127.746411] [017/132] (891s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[127.872702] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[128.840390] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.966s)
[129.674190] [018/132] (889s left) perf_pmu (interrupts)
[129.729443] Starting subtest: interrupts
[130.818086] Subtest interrupts: SUCCESS (1.088s)
[130.962296] [019/132] (887s left) kms_psr (psr2-primary-mmap-cpu)
[131.060032] Starting subtest: psr2-primary-mmap-cpu
[131.062917] Starting dynamic subtest: eDP-1
[132.752820] Dynamic subtest eDP-1: SUCCESS (1.694s)
[132.755245] Subtest psr2-primary-mmap-cpu: SUCCESS (1.695s)
[133.652220] [020/132] (885s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[133.723686] Starting subtest: wait-all-for-submit-delayed-submit
[133.826371] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[133.923299] [021/132] (885s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[138.937269] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[138.939555] Starting dynamic subtest: pipe-A-eDP-1
[139.727770] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[139.736990] Starting dynamic subtest: pipe-B-eDP-1
[140.856210] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[140.860504] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.917s)
[142.072858] [022/132] (876s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[142.169050] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[142.171287] Starting dynamic subtest: pipe-A-eDP-1
[142.226247] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[142.234518] Starting dynamic subtest: pipe-B-eDP-1
[142.291797] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[142.301113] Starting dynamic subtest: pipe-C-eDP-1
[142.357837] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[142.366579] Starting dynamic subtest: pipe-D-eDP-1
[142.423982] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[142.428056] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[144.428785] [023/132] (874s left) gem_exec_balancer (nop)
[144.499266] Starting subtest: nop
[191.179642] Subtest nop: SUCCESS (46.678s)
[191.528177] [024/132] (827s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[191.622720] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[191.634338] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[191.769354] [025/132] (827s left) core_sysfs (read-all-entries)
[191.825568] Starting subtest: read-all-entries
[191.835078] Subtest read-all-entries: SUCCESS (0.012s)
[191.958743] [026/132] (827s left) i915_drm_fdinfo (virtual-busy-hang-all)
[192.004562] Starting subtest: virtual-busy-hang-all
[192.008883] Subtest virtual-busy-hang-all: SKIP (0.000s)
[192.104862] [027/132] (827s left) gem_pxp (fail-invalid-protected-context)
[192.238076] Starting subtest: fail-invalid-protected-context
[192.240393] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[192.377687] [028/132] (826s left) kms_color (invalid-degamma-lut-sizes)
[192.466562] Starting subtest: invalid-degamma-lut-sizes
[192.468529] Starting dynamic subtest: pipe-A
[192.761322] Dynamic subtest pipe-A: SUCCESS (0.295s)
[192.770752] Starting dynamic subtest: pipe-B
[192.773119] Dynamic subtest pipe-B: SUCCESS (0.001s)
[192.780797] Starting dynamic subtest: pipe-C
[192.783262] Dynamic subtest pipe-C: SUCCESS (0.001s)
[192.791214] Starting dynamic subtest: pipe-D
[192.793584] Dynamic subtest pipe-D: SUCCESS (0.001s)
[192.795887] Subtest invalid-degamma-lut-sizes: SUCCESS (0.299s)
[193.638806] [029/132] (825s left) gem_create (create-ext-cpu-access-big)
[193.835705] Starting subtest: create-ext-cpu-access-big
[193.840195] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[193.929396] [030/132] (825s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[194.040954] Starting subtest: fbc-rgb101010-draw-pwrite
[199.377991] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.341s)
[200.537935] [031/132] (818s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[200.664475] Starting subtest: x-tiled-8bpp-rotate-270
[200.685327] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[200.854307] [032/132] (818s left) gem_softpin (safe-alignment)
[200.916476] Starting subtest: safe-alignment
[200.937783] Subtest safe-alignment: SUCCESS (0.021s)
[202.964398] [033/132] (816s left) gem_exec_schedule (semaphore-codependency)
[203.037477] Starting subtest: semaphore-codependency
[203.042896] Subtest semaphore-codependency: SUCCESS (0.012s)
[203.408320] [034/132] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[203.511399] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[203.515481] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[203.639342] [035/132] (815s left) kms_sequence (queue-idle)
[203.737930] Starting subtest: queue-idle
[203.739919] Starting dynamic subtest: pipe-A-eDP-1
[205.552375] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[205.560819] Starting dynamic subtest: pipe-B-eDP-1
[208.070277] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.517s)
[208.078672] Starting dynamic subtest: pipe-C-eDP-1
[210.470545] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.399s)
[210.483091] Starting dynamic subtest: pipe-D-eDP-1
[212.902055] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[212.904553] Subtest queue-idle: SUCCESS (9.164s)
[213.728536] [036/132] (805s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[213.823094] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[213.825321] Starting dynamic subtest: pipe-A-default-mode
[214.114769] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[214.119336] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.290s)
[214.955816] [037/132] (804s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[215.063634] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[215.067635] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[215.199782] [038/132] (804s left) kms_flip (flip-vs-expired-vblank-interruptible)
[215.309230] Starting subtest: flip-vs-expired-vblank-interruptible
[215.311435] Starting dynamic subtest: A-eDP1
[223.928563] Dynamic subtest A-eDP1: SUCCESS (8.617s)
[223.937205] Starting dynamic subtest: B-eDP1
[232.551753] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[232.560789] Starting dynamic subtest: C-eDP1
[241.165663] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[241.174265] Starting dynamic subtest: D-eDP1
[249.792499] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[249.794999] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.484s)
[250.991366] [039/132] (768s left) gem_ctx_persistence (smoketest)
[251.066483] Starting subtest: smoketest
[291.895075] Subtest smoketest: SUCCESS (40.828s)
[291.997212] [040/132] (727s left) kms_cursor_crc (cursor-onscreen-256x85)
[292.259974] Starting subtest: cursor-onscreen-256x85
[292.305693] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[292.494386] [041/132] (727s left) gem_flink_basic (double-flink)
[292.553574] Starting subtest: double-flink
[292.555883] Subtest double-flink: SUCCESS (0.000s)
[292.680670] [042/132] (727s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[292.773794] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[299.489281] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.717s)
[299.655493] [043/132] (720s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[299.754233] Starting subtest: extended-modeset-hang-oldfb-with-reset
[299.756625] Starting dynamic subtest: pipe-A
[311.269570] Dynamic subtest pipe-A: SUCCESS (11.513s)
[311.280448] Starting dynamic subtest: pipe-D
[323.538766] Dynamic subtest pipe-D: SUCCESS (12.267s)
[323.541607] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.784s)
[324.398337] [044/132] (695s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[324.504510] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[324.506840] Starting dynamic subtest: pipe-A-eDP-1
[326.697893] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.194s)
[326.706070] Starting dynamic subtest: pipe-B-eDP-1
[328.894887] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.195s)
[328.902946] Starting dynamic subtest: pipe-C-eDP-1
[331.005988] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.111s)
[331.014136] Starting dynamic subtest: pipe-D-eDP-1
[333.058596] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.051s)
[333.060845] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.556s)
[334.292720] [045/132] (685s left) i915_selftest (live)
[337.741056] Starting subtest: live
[337.743603] Starting dynamic subtest: sanitycheck
[340.584465] Dynamic subtest sanitycheck: SUCCESS (2.843s)
[340.593962] Starting dynamic subtest: uncore
[344.971072] Dynamic subtest uncore: SUCCESS (4.384s)
[344.984681] Starting dynamic subtest: workarounds
[348.242090] Dynamic subtest workarounds: SUCCESS (3.268s)
[348.251390] Starting dynamic subtest: gt_engines
[352.940676] Dynamic subtest gt_engines: SUCCESS (4.696s)
[352.949408] Starting dynamic subtest: gt_timelines
[370.741669] Dynamic subtest gt_timelines: SUCCESS (17.798s)
[370.750663] Starting dynamic subtest: gt_contexts
[375.233050] Dynamic subtest gt_contexts: SUCCESS (4.489s)
[375.242253] Starting dynamic subtest: gt_lrc
[381.599559] Dynamic subtest gt_lrc: SUCCESS (6.364s)
[381.608695] Starting dynamic subtest: gt_mocs
[384.697983] Dynamic subtest gt_mocs: SUCCESS (3.096s)
[384.711970] Starting dynamic subtest: gt_pm
[391.567555] Dynamic subtest gt_pm: SUCCESS (6.866s)
[391.576764] Starting dynamic subtest: gt_heartbeat
[396.026920] Dynamic subtest gt_heartbeat: SUCCESS (4.457s)
[396.036554] Starting dynamic subtest: gt_tlb
[405.388977] Dynamic subtest gt_tlb: SUCCESS (9.359s)
[405.397767] Starting dynamic subtest: requests
[417.213050] Dynamic subtest requests: SUCCESS (11.820s)
[417.222472] Starting dynamic subtest: migrate
[423.356330] Dynamic subtest migrate: SUCCESS (6.141s)
[423.365470] Starting dynamic subtest: active
[427.842580] Dynamic subtest active: SUCCESS (4.484s)
[427.851694] Starting dynamic subtest: objects
[432.662062] Dynamic subtest objects: SUCCESS (4.817s)
[432.671535] Starting dynamic subtest: mman
[437.630595] Dynamic subtest mman: SUCCESS (4.966s)
[437.639969] Starting dynamic subtest: dmabuf
[442.180992] Dynamic subtest dmabuf: SUCCESS (4.548s)
[442.189602] Starting dynamic subtest: vma
[446.637422] Dynamic subtest vma: SUCCESS (4.454s)
[446.646251] Starting dynamic subtest: coherency
[451.684373] Dynamic subtest coherency: SUCCESS (5.045s)
[451.693214] Starting dynamic subtest: gtt
[463.910330] Dynamic subtest gtt: SUCCESS (12.222s)
[463.919887] Starting dynamic subtest: gem
[471.797839] Dynamic subtest gem: SUCCESS (7.885s)
[471.807076] Starting dynamic subtest: evict
[477.424381] Dynamic subtest evict: SUCCESS (5.623s)
[477.433537] Starting dynamic subtest: hugepages
[488.562096] Dynamic subtest hugepages: SUCCESS (11.135s)
[488.571247] Starting dynamic subtest: gem_contexts
[517.571031] Dynamic subtest gem_contexts: SUCCESS (29.006s)
[517.579598] Starting dynamic subtest: client
[522.130527] Dynamic subtest client: SUCCESS (4.558s)
[522.139256] Starting dynamic subtest: gem_migrate
[526.518012] Dynamic subtest gem_migrate: SUCCESS (4.385s)
[526.531787] Starting dynamic subtest: reset
[529.431305] Dynamic subtest reset: SUCCESS (2.912s)
[529.439972] Starting dynamic subtest: memory_region
[533.874453] Dynamic subtest memory_region: SUCCESS (4.440s)
[533.889073] Starting dynamic subtest: hangcheck
[547.484784] Dynamic subtest hangcheck: SUCCESS (13.607s)
[547.498996] Starting dynamic subtest: execlists
[551.894279] Dynamic subtest execlists: SUCCESS (4.383s)
[551.901637] Starting dynamic subtest: ring_submission
[556.339631] Dynamic subtest ring_submission: SUCCESS (4.467s)
[556.348659] Starting dynamic subtest: perf
[559.273508] Dynamic subtest perf: SUCCESS (2.932s)
[559.287795] Starting dynamic subtest: slpc
[573.415937] Dynamic subtest slpc: SUCCESS (14.140s)
[573.429439] Starting dynamic subtest: guc
[577.461307] Dynamic subtest guc: SUCCESS (4.043s)
[577.475555] Starting dynamic subtest: guc_multi_lrc
[581.881349] Dynamic subtest guc_multi_lrc: SUCCESS (4.399s)
[581.889227] Starting dynamic subtest: guc_hang
[586.972907] Dynamic subtest guc_hang: SUCCESS (5.107s)
[586.981907] Starting dynamic subtest: late_gt_pm
[591.389991] Dynamic subtest late_gt_pm: SUCCESS (4.415s)
[591.392701] Subtest live: SUCCESS (253.638s)
[591.422435] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[591.423133] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[591.426070] [046/132] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[593.066560] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[593.070638] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[593.172764] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[593.174049] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[593.178511] [047/132] (426s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[593.285175] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[593.289394] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[593.416894] [048/132] (426s left) perf (polling)
[593.557900] Starting subtest: polling
[593.559952] Starting dynamic subtest: 0-rcs0
[603.584993] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[603.592615] Starting dynamic subtest: 1-vcs1
[613.606660] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[613.609047] Subtest polling: SUCCESS (20.048s)
[613.655649] [049/132] (406s left) kms_flip (plain-flip-fb-recreate)
[613.747984] Starting subtest: plain-flip-fb-recreate
[613.750181] Starting dynamic subtest: A-eDP1
[622.631317] Dynamic subtest A-eDP1: SUCCESS (8.884s)
[622.647187] Starting dynamic subtest: B-eDP1
[631.462189] Dynamic subtest B-eDP1: SUCCESS (8.828s)
[631.473570] Starting dynamic subtest: C-eDP1
[640.283478] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[640.292092] Starting dynamic subtest: D-eDP1
[649.105504] Dynamic subtest D-eDP1: SUCCESS (8.820s)
[649.110038] Subtest plain-flip-fb-recreate: SUCCESS (35.362s)
[650.313974] [050/132] (369s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[650.441813] Starting subtest: cursor-vs-flip-atomic-transitions
[680.336568] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.892s)
[681.242011] [051/132] (338s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[681.351279] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[685.498618] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.153s)
[686.639930] [052/132] (333s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[686.758908] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[686.763026] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[686.895531] [053/132] (333s left) gem_flink_basic (flink-lifetime)
[686.952841] Starting subtest: flink-lifetime
[686.955148] Subtest flink-lifetime: SUCCESS (0.002s)
[687.090148] [054/132] (333s left) gem_exec_reloc (basic-cpu-read-noreloc)
[687.156268] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[687.242393] [055/132] (333s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[687.310955] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[687.313360] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[687.458915] [056/132] (332s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[687.521446] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[687.525762] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[687.725042] [057/132] (332s left) kms_mmap_write_crc (main)
[687.831789] Starting subtest: main
[687.834081] Starting dynamic subtest: pipe-A-eDP-1
[691.336880] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[691.339163] Subtest main: SUCCESS (3.502s)
[692.167091] [058/132] (328s left) gem_exec_whisper (basic-queues-all)
[692.237550] Starting subtest: basic-queues-all
[703.514391] Subtest basic-queues-all: SUCCESS (11.273s)
[703.723563] [059/132] (316s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[703.824080] Starting subtest: fbc-pr-sprite-mmap-cpu
[703.828530] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[703.918898] [060/132] (316s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[704.037053] Starting subtest: flip-vs-cursor-atomic
[711.162168] Subtest flip-vs-cursor-atomic: SUCCESS (7.127s)
[711.994086] [061/132] (308s left) api_intel_bb (simple-bb)
[712.061604] Starting subtest: simple-bb
[712.066730] Subtest simple-bb: SUCCESS (0.007s)
[712.220459] [062/132] (308s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[712.269156] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[712.323893] [063/132] (308s left) kms_invalid_mode (bad-vsync-end)
[712.416581] Starting subtest: bad-vsync-end
[712.418896] Starting dynamic subtest: pipe-A-eDP-1
[712.714148] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[712.723281] Starting dynamic subtest: pipe-B-eDP-1
[712.725367] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[712.733340] Starting dynamic subtest: pipe-C-eDP-1
[712.735741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[712.743846] Starting dynamic subtest: pipe-D-eDP-1
[712.746115] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[712.748510] Subtest bad-vsync-end: SUCCESS (0.302s)
[713.532697] [064/132] (307s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[713.579246] Starting subtest: framebuffer-vs-set-tiling
[713.583409] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[713.734365] [065/132] (307s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[713.837391] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[713.839756] Starting dynamic subtest: pipe-A-default-mode
[714.976451] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[714.980658] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.137s)
[715.175015] [066/132] (305s left) gem_lmem_swapping (verify-ccs)
[715.223641] Subtest verify-ccs: SKIP (0.000s)
[715.262459] [067/132] (305s left) vgem_basic (bad-flag)
[715.308654] Starting subtest: bad-flag
[715.310623] Subtest bad-flag: SUCCESS (0.000s)
[715.384561] [068/132] (305s left) kms_big_fb (linear-32bpp-rotate-180)
[715.510682] Starting subtest: linear-32bpp-rotate-180
[717.064423] Subtest linear-32bpp-rotate-180: SUCCESS (1.553s)
[717.238251] [069/132] (303s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[717.302512] Subtest writes-after-reads: SKIP (0.000s)
[717.377803] [070/132] (303s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[717.483912] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[717.487486] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[717.624717] [071/132] (303s left) gem_ctx_bad_destroy (double-destroy)
[717.669931] Starting subtest: double-destroy
[717.672295] Subtest double-destroy: SUCCESS (0.000s)
[717.774136] [072/132] (303s left) kms_chamelium_color (ctm-blue-to-red)
[717.862263] Subtest ctm-blue-to-red: SKIP (0.000s)
[717.921112] [073/132] (303s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[718.025454] Starting subtest: fbc-psr-cursor-mmap-cpu
[718.027235] Starting dynamic subtest: eDP-1
[718.030499] Dynamic subtest eDP-1: SKIP (0.000s)
[718.033778] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[718.122242] [074/132] (302s left) i915_drm_fdinfo (isolation)
[718.160739] Starting subtest: isolation
[718.162545] Starting dynamic subtest: rcs0
[718.181150] Dynamic subtest rcs0: SKIP (0.020s)
[718.190203] Starting dynamic subtest: bcs0
[718.201817] Dynamic subtest bcs0: SKIP (0.020s)
[718.209748] Starting dynamic subtest: vcs0
[718.213248] Dynamic subtest vcs0: SKIP (0.000s)
[718.221480] Starting dynamic subtest: vcs1
[718.225382] Dynamic subtest vcs1: SKIP (0.000s)
[718.235647] Starting dynamic subtest: vecs0
[718.239259] Dynamic subtest vecs0: SKIP (0.000s)
[718.247053] Starting dynamic subtest: ccs0
[718.250661] Dynamic subtest ccs0: SKIP (0.000s)
[718.254263] Subtest isolation: SKIP (0.047s)
[718.298946] [075/132] (302s left) gem_ctx_sseu (invalid-args)
[718.345212] Subtest invalid-args: SKIP (0.000s)
[718.408827] [076/132] (302s left) gen9_exec_parse (allowed-all)
[718.478457] Subtest allowed-all: SKIP (0.000s)
[718.551709] [077/132] (302s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[723.550260] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[723.552637] Starting dynamic subtest: pipe-A-eDP-1
[730.431452] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.878s)
[730.442253] Starting dynamic subtest: pipe-B-eDP-1
[737.494903] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.058s)
[737.497530] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.941s)
[738.384629] [078/132] (282s left) kms_chamelium_frames (dp-crc-multiple)
[738.786432] Subtest dp-crc-multiple: SKIP (0.000s)
[739.576149] [079/132] (281s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[739.677088] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[739.679381] Starting dynamic subtest: pipe-A
[739.697754] Dynamic subtest pipe-A: SKIP (0.017s)
[739.706793] Starting dynamic subtest: pipe-B
[739.730671] Dynamic subtest pipe-B: SKIP (0.030s)
[739.739200] Starting dynamic subtest: pipe-C
[739.760039] Dynamic subtest pipe-C: SKIP (0.029s)
[739.768797] Starting dynamic subtest: pipe-D
[739.788283] Dynamic subtest pipe-D: SKIP (0.029s)
[739.791947] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.109s)
[739.917826] [080/132] (281s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[740.027791] Starting subtest: y-tiled-8bpp-rotate-270
[740.032254] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[740.139902] [081/132] (281s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[740.241875] Starting subtest: psr-rgb565-draw-blt
[747.253049] Subtest psr-rgb565-draw-blt: SUCCESS (7.013s)
[747.422396] [082/132] (274s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[747.546302] Starting subtest: cursorB-vs-flipA-atomic-transitions
[747.550648] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[747.719044] [083/132] (273s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[747.823327] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[754.718068] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.895s)
[754.916694] [084/132] (266s left) kms_big_fb (4-tiled-addfb)
[755.031761] Starting subtest: 4-tiled-addfb
[755.034074] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[755.180250] [085/132] (266s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[755.575849] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[756.367948] [086/132] (265s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[756.462954] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[756.467307] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[756.604659] [087/132] (265s left) gem_mmap_gtt (big-bo-tiledy)
[756.660591] Subtest big-bo-tiledY: SKIP (0.000s)
[756.731908] [088/132] (264s left) gem_ctx_persistence (engines-hang)
[756.796835] Starting subtest: engines-hang
[756.799234] Starting dynamic subtest: rcs0
[756.903316] Dynamic subtest rcs0: SUCCESS (0.109s)
[756.914532] Starting dynamic subtest: bcs0
[757.024784] Dynamic subtest bcs0: SUCCESS (0.120s)
[757.036564] Starting dynamic subtest: vcs0
[757.138968] Dynamic subtest vcs0: SUCCESS (0.112s)
[757.150143] Starting dynamic subtest: vcs1
[757.266935] Dynamic subtest vcs1: SUCCESS (0.126s)
[757.277985] Starting dynamic subtest: vecs0
[757.381159] Dynamic subtest vecs0: SUCCESS (0.113s)
[757.394055] Starting dynamic subtest: ccs0
[757.494199] Dynamic subtest ccs0: SUCCESS (0.111s)
[757.496340] Subtest engines-hang: SUCCESS (0.702s)
[757.594688] [089/132] (264s left) prime_self_import (export-vs-gem_close-race)
[757.628616] Starting subtest: export-vs-gem_close-race
[762.738454] Subtest export-vs-gem_close-race: SUCCESS (5.110s)
[762.852515] [090/132] (258s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[762.990341] Starting subtest: 4-tiled-16bpp-rotate-0
[764.337520] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.348s)
[764.510521] [091/132] (257s left) drm_read (short-buffer-block)
[764.663131] Starting subtest: short-buffer-block
[764.665164] Subtest short-buffer-block: SUCCESS (0.000s)
[764.835092] [092/132] (257s left) sriov_basic (bind-unbind-vf)
[764.888037] Starting subtest: bind-unbind-vf
[764.890120] Starting dynamic subtest: vf-1
[764.959085] Dynamic subtest vf-1: FAIL (0.027s)
[764.969211] Starting dynamic subtest: vf-2
[765.032474] Dynamic subtest vf-2: FAIL (0.004s)
[765.041307] Starting dynamic subtest: vf-3
[765.101802] Dynamic subtest vf-3: FAIL (0.004s)
[765.110544] Starting dynamic subtest: vf-4
[765.170799] Dynamic subtest vf-4: FAIL (0.004s)
[765.179243] Starting dynamic subtest: vf-5
[765.239786] Dynamic subtest vf-5: FAIL (0.004s)
[765.249397] Starting dynamic subtest: vf-6
[765.309568] Dynamic subtest vf-6: FAIL (0.004s)
[765.321040] Starting dynamic subtest: vf-7
[765.380761] Dynamic subtest vf-7: FAIL (0.003s)
[765.390306] Starting dynamic subtest: vf-random
[765.450045] Dynamic subtest vf-random: FAIL (0.004s)
[765.460084] Starting dynamic subtest: vf-last
[765.519931] Dynamic subtest vf-last: FAIL (0.004s)
[765.521925] Subtest bind-unbind-vf: FAIL (0.067s)
[765.559521] [093/132] (256s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[765.620467] Starting subtest: multi-wait-all-available-submitted-signaled
[765.622506] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[765.742766] [094/132] (256s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[765.855284] Starting subtest: cursor-tearing-framebuffer-change
[765.857138] Starting dynamic subtest: pipe-A-eDP-1
[766.420964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[766.432499] Starting dynamic subtest: pipe-D-eDP-1
[767.613062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s)
[767.615469] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.757s)
[768.471847] [095/132] (253s left) gem_mmap_wc (write-wc-read-gtt)
[768.536821] Subtest write-wc-read-gtt: SKIP (0.000s)
[768.592595] [096/132] (253s left) kms_flip (bo-too-big-interruptible)
[768.699472] Starting subtest: bo-too-big-interruptible
[768.701735] Starting dynamic subtest: A-eDP1
[770.015327] Dynamic subtest A-eDP1: SUCCESS (1.315s)
[770.026143] Starting dynamic subtest: B-eDP1
[771.249810] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[771.261999] Starting dynamic subtest: C-eDP1
[772.491990] Dynamic subtest C-eDP1: SUCCESS (1.240s)
[772.503323] Starting dynamic subtest: D-eDP1
[773.828090] Dynamic subtest D-eDP1: SUCCESS (1.333s)
[773.830387] Subtest bo-too-big-interruptible: SUCCESS (5.132s)
[775.058593] [097/132] (247s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[775.168899] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[779.639731] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.475s)
[780.873501] [098/132] (241s left) gem_mmap_gtt (ptrace)
[780.931405] Subtest ptrace: SKIP (0.000s)
[780.997069] [099/132] (241s left) gem_exec_gttfill (engines)
[781.057483] Starting subtest: engines
[781.059672] Starting dynamic subtest: rcs0
[803.999970] Dynamic subtest rcs0: SUCCESS (22.941s)
[804.010083] Starting dynamic subtest: bcs0
[827.329729] Dynamic subtest bcs0: SUCCESS (23.325s)
[827.338864] Starting dynamic subtest: vcs0
[850.595902] Dynamic subtest vcs0: SUCCESS (23.263s)
[850.610843] Starting dynamic subtest: vcs1
[873.988393] Dynamic subtest vcs1: SUCCESS (23.388s)
[874.000040] Starting dynamic subtest: vecs0
[897.306225] Dynamic subtest vecs0: SUCCESS (23.314s)
[897.315254] Starting dynamic subtest: ccs0
[920.545281] Dynamic subtest ccs0: SUCCESS (23.237s)
[920.547735] Subtest engines: SUCCESS (139.482s)
[920.761513] [100/132] (101s left) gem_ppgtt (blt-vs-render-ctx0)
[920.861205] Starting subtest: blt-vs-render-ctx0
[953.796437] Subtest blt-vs-render-ctx0: SUCCESS (32.932s)
[953.972439] [101/132] ( 68s left) dumb_buffer (map-valid)
[954.071528] Starting subtest: map-valid
[954.073478] Subtest map-valid: SUCCESS (0.000s)
[954.211314] [102/132] ( 68s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[954.320355] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[954.324944] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[954.446108] [103/132] ( 67s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[954.541377] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[954.545623] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[954.686664] [104/132] ( 67s left) prime_busy (after)
[954.752710] Starting subtest: after
[954.755061] Starting dynamic subtest: rcs0
[954.798730] Dynamic subtest rcs0: SUCCESS (0.045s)
[954.807444] Starting dynamic subtest: bcs0
[954.837477] Dynamic subtest bcs0: SUCCESS (0.038s)
[954.845518] Starting dynamic subtest: vcs0
[954.875093] Dynamic subtest vcs0: SUCCESS (0.037s)
[954.882912] Starting dynamic subtest: vcs1
[954.915433] Dynamic subtest vcs1: SUCCESS (0.039s)
[954.923417] Starting dynamic subtest: vecs0
[954.956379] Dynamic subtest vecs0: SUCCESS (0.040s)
[954.973532] Starting dynamic subtest: ccs0
[954.998624] Dynamic subtest ccs0: SUCCESS (0.040s)
[955.107699] Subtest after: SUCCESS (0.355s)
[955.203726] [105/132] ( 67s left) gem_exec_store (cachelines)
[955.270164] Starting subtest: cachelines
[955.272548] Starting dynamic subtest: rcs0
[955.383954] Dynamic subtest rcs0: SUCCESS (0.113s)
[955.395398] Starting dynamic subtest: bcs0
[955.450377] Dynamic subtest bcs0: SUCCESS (0.064s)
[955.461568] Starting dynamic subtest: vcs0
[955.506629] Dynamic subtest vcs0: SUCCESS (0.054s)
[955.517402] Starting dynamic subtest: vcs1
[955.570574] Dynamic subtest vcs1: SUCCESS (0.062s)
[955.582673] Starting dynamic subtest: vecs0
[955.630096] Dynamic subtest vecs0: SUCCESS (0.057s)
[955.641344] Starting dynamic subtest: ccs0
[955.690420] Dynamic subtest ccs0: SUCCESS (0.058s)
[955.692886] Subtest cachelines: SUCCESS (0.422s)
[955.898894] [106/132] ( 66s left) gem_exec_reloc (basic-wc)
[955.956643] Subtest basic-wc: SKIP (0.000s)
[956.038049] [107/132] ( 66s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[956.115456] Starting subtest: multi-wait-for-submit-submitted-signaled
[956.117904] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[956.261056] [108/132] ( 66s left) kms_hdr (bpc-switch-suspend)
[956.358436] Starting subtest: bpc-switch-suspend
[957.389274] Starting dynamic subtest: pipe-A-eDP-1
[977.072432] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.429s)
[977.074853] Subtest bpc-switch-suspend: SUCCESS (9.462s)
[977.235426] [109/132] ( 45s left) kms_pm_dc (dc5-dpms)
[978.356271] Starting subtest: dc5-dpms
[980.408482] Subtest dc5-dpms: SUCCESS (2.047s)
[980.513277] [110/132] ( 42s left) api_intel_allocator (execbuf-with-allocator)
[980.575828] Starting subtest: execbuf-with-allocator
[980.582614] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[980.747415] [111/132] ( 41s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[980.856519] Starting subtest: fbcpsr-stridechange
[987.040750] Subtest fbcpsr-stridechange: SUCCESS (6.184s)
[987.225419] [112/132] ( 35s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[987.331372] Starting subtest: yf-tiled-32bpp-rotate-90
[987.335919] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[987.463627] [113/132] ( 35s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[987.553461] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[987.557986] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[987.687955] [114/132] ( 35s left) gem_exec_balancer (parallel-keep-submit-fence)
[987.944660] Starting subtest: parallel-keep-submit-fence
[989.073228] Subtest parallel-keep-submit-fence: SUCCESS (1.128s)
[989.211840] [115/132] ( 33s left) kms_cursor_crc (cursor-size-change)
[989.300171] Starting subtest: cursor-size-change
[989.302064] Starting dynamic subtest: pipe-A-eDP-1
[990.116113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.815s)
[990.126784] Starting dynamic subtest: pipe-D-eDP-1
[991.538548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.419s)
[991.540877] Subtest cursor-size-change: SUCCESS (2.238s)
[992.370544] [116/132] ( 30s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[992.426514] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[992.428715] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[992.558404] [117/132] ( 30s left) gem_exec_reloc (basic-write-gtt-active)
[992.626219] Subtest basic-write-gtt-active: SKIP (0.000s)
[992.710110] [118/132] ( 30s left) syncobj_basic (test-valid-cycle)
[992.776693] Starting subtest: test-valid-cycle
[992.779116] Subtest test-valid-cycle: SUCCESS (0.000s)
[992.912673] [119/132] ( 30s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[993.005468] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[993.007689] Starting dynamic subtest: pipe-A-eDP-1
[993.016711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[993.029112] Starting dynamic subtest: pipe-B-eDP-1
[993.038165] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[993.049841] Starting dynamic subtest: pipe-C-eDP-1
[993.059373] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[993.075012] Starting dynamic subtest: pipe-D-eDP-1
[993.083923] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[993.088267] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[995.264674] [120/132] ( 27s left) gem_unfence_active_buffers
[995.438618] [121/132] ( 27s left) kms_universal_plane (disable-primary-vs-flip)
[995.546102] Starting subtest: disable-primary-vs-flip
[995.548203] Starting dynamic subtest: pipe-A-eDP-1
[997.127281] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.580s)
[997.143572] Starting dynamic subtest: pipe-B-eDP-1
[999.386097] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.256s)
[999.396699] Starting dynamic subtest: pipe-C-eDP-1
[1001.618851] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.231s)
[1001.628825] Starting dynamic subtest: pipe-D-eDP-1
[1003.787234] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[1003.789399] Subtest disable-primary-vs-flip: SUCCESS (8.239s)
[1004.604317] [122/132] ( 18s left) kms_addfb_basic (invalid-set-prop)
[1004.668005] Starting subtest: invalid-set-prop
[1004.670082] Subtest invalid-set-prop: SUCCESS (0.000s)
[1004.834652] [123/132] ( 18s left) kms_psr (pr-primary-mmap-gtt)
[1004.934050] Starting subtest: pr-primary-mmap-gtt
[1004.938358] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[1005.030503] [124/132] ( 18s left) kms_cursor_legacy (torture-move)
[1005.153426] Starting subtest: torture-move
[1005.155561] Starting dynamic subtest: pipe-A
[1011.353754] Dynamic subtest pipe-A: SUCCESS (6.195s)
[1011.365699] Starting dynamic subtest: pipe-B
[1018.734916] Dynamic subtest pipe-B: SUCCESS (7.376s)
[1018.748229] Starting dynamic subtest: pipe-C
[1024.627782] Dynamic subtest pipe-C: SUCCESS (5.889s)
[1024.643985] Starting dynamic subtest: pipe-D
[1030.477684] Dynamic subtest pipe-D: SUCCESS (5.847s)
[1030.491279] Starting dynamic subtest: all-pipes
[1036.895806] Dynamic subtest all-pipes: SUCCESS (6.414s)
[1036.898566] Subtest torture-move: SUCCESS (31.732s)
[1037.058118] Overall timeout time exceeded, stopping.
[1037.075099] 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: no output, setting notrun
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.