[55.731715] Initializing watchdogs [55.731808] /dev/watchdog0 [55.748420] [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] [55.752898] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.754936] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.756839] [001/131] (960s left) perf (gen12-invalid-class-instance) [55.865100] Starting subtest: gen12-invalid-class-instance [55.874128] Subtest gen12-invalid-class-instance: SUCCESS (0.010s) [55.914270] [002/131] (960s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [60.978559] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [60.980528] Starting dynamic subtest: pipe-A-eDP-1 [61.797244] Dynamic subtest pipe-A-eDP-1: SKIP (0.813s) [61.805088] Starting dynamic subtest: pipe-B-eDP-1 [62.926125] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [62.927878] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.940s) [64.104120] [003/131] (952s left) kms_chamelium_frames (vga-frame-dump) [64.481513] Subtest vga-frame-dump: SKIP (0.000s) [65.314146] [004/131] (951s left) sysfs_timeslice_duration (idempotent) [65.369663] Starting subtest: idempotent [65.370601] Starting dynamic subtest: vecs0 [65.371539] Dynamic subtest vecs0: SUCCESS (0.000s) [65.378884] Starting dynamic subtest: ccs0 [65.379755] Dynamic subtest ccs0: SUCCESS (0.000s) [65.384918] Starting dynamic subtest: vcs0 [65.385848] Dynamic subtest vcs0: SUCCESS (0.000s) [65.390887] Starting dynamic subtest: bcs0 [65.391762] Dynamic subtest bcs0: SUCCESS (0.000s) [65.396787] Starting dynamic subtest: rcs0 [65.397666] Dynamic subtest rcs0: SUCCESS (0.000s) [65.402800] Starting dynamic subtest: vcs1 [65.403734] Dynamic subtest vcs1: SUCCESS (0.000s) [65.404649] Subtest idempotent: SUCCESS (0.003s) [65.476523] [005/131] (950s left) kms_flip (flip-vs-suspend) [65.558417] Starting subtest: flip-vs-suspend [65.559400] Starting dynamic subtest: A-eDP1 [99.139883] Dynamic subtest A-eDP1: SUCCESS (4.331s) [99.147640] Starting dynamic subtest: B-eDP1 [133.137709] Dynamic subtest B-eDP1: SUCCESS (4.520s) [133.148845] Starting dynamic subtest: C-eDP1 [167.149621] Dynamic subtest C-eDP1: SUCCESS (4.092s) [167.159755] Starting dynamic subtest: D-eDP1 [201.146074] Dynamic subtest D-eDP1: SUCCESS (4.102s) [201.167809] Subtest flip-vs-suspend: SUCCESS (17.051s) [208.374246] [006/131] (814s left) gem_set_tiling_vs_pwrite [208.485681] [007/131] (813s left) syncobj_timeline (invalid-transfer-bad-pad) [208.541482] Starting subtest: invalid-transfer-bad-pad [208.542471] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [208.628263] [008/131] (813s left) i915_hangman (hangcheck-unterminated) [208.688599] Starting subtest: hangcheck-unterminated [220.379773] Subtest hangcheck-unterminated: SUCCESS (11.599s) [220.504835] [009/131] (801s left) perf (missing-sample-flags) [220.585005] Starting subtest: missing-sample-flags [220.586013] Subtest missing-sample-flags: SUCCESS (0.000s) [220.618191] [010/131] (801s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [220.715425] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [220.717188] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [220.823169] [011/131] (801s left) kms_properties (plane-properties-atomic) [220.914312] Starting subtest: plane-properties-atomic [220.915350] Starting dynamic subtest: pipe-A-eDP-1 [221.465219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s) [221.472662] Starting dynamic subtest: pipe-B-eDP-1 [222.746106] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.277s) [222.755047] Starting dynamic subtest: pipe-C-eDP-1 [223.984633] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s) [223.991598] Starting dynamic subtest: pipe-D-eDP-1 [225.204351] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s) [225.205304] Subtest plane-properties-atomic: SUCCESS (4.278s) [226.006480] [012/131] (796s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [226.109451] Starting subtest: cursorB-vs-flipB-atomic-transitions [226.111220] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [226.246511] [013/131] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [226.337797] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [226.339527] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [226.424029] [014/131] (796s left) kms_addfb_basic (clobberred-modifier) [226.469408] Starting subtest: clobberred-modifier [226.471303] Subtest clobberred-modifier: SKIP (0.000s) [226.625667] [015/131] (796s left) gem_exec_fence (concurrent) [226.806973] Starting subtest: concurrent [226.809346] Subtest concurrent: SKIP (0.000s) [228.459580] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true [228.461380] [016/131] (794s left) gem_mmap_gtt (big-copy) [228.512099] Subtest big-copy: SKIP (0.000s) [228.577918] [017/131] (794s left) kms_color (gamma) [228.663768] Starting subtest: gamma [228.664794] Starting dynamic subtest: pipe-A-eDP-1 [229.352853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s) [229.359980] Starting dynamic subtest: pipe-B-eDP-1 [230.700537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.345s) [230.707505] Starting dynamic subtest: pipe-C-eDP-1 [231.981202] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s) [231.989379] Starting dynamic subtest: pipe-D-eDP-1 [233.309688] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s) [233.310770] Subtest gamma: SUCCESS (4.641s) [234.143649] [018/131] (788s left) kms_plane_multiple (2x-tiling-4) [234.227220] Starting subtest: 2x-tiling-4 [234.228907] Subtest 2x-tiling-4: SKIP (0.000s) [234.292410] [019/131] (788s left) api_intel_bb (blit-reloc-purge-cache) [234.342861] Starting subtest: blit-reloc-purge-cache [234.345039] Subtest blit-reloc-purge-cache: SKIP (0.001s) [234.459666] [020/131] (788s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [234.571967] Starting subtest: flip-vs-cursor-busy-crc-atomic [235.319934] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.746s) [236.171734] [021/131] (786s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [236.229065] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [236.230251] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [236.321389] [022/131] (786s left) gem_ctx_isolation (preservation-s3) [236.381513] Starting subtest: preservation-S3 [236.382869] Starting dynamic subtest: rcs0 [253.223705] Dynamic subtest rcs0: SUCCESS (1.725s) [253.233236] Starting dynamic subtest: bcs0 [270.158773] Dynamic subtest bcs0: SUCCESS (1.630s) [270.167047] Starting dynamic subtest: vcs0 [287.151156] Dynamic subtest vcs0: SUCCESS (3.076s) [287.158803] Starting dynamic subtest: vcs1 [305.214758] Dynamic subtest vcs1: SUCCESS (5.028s) [305.222424] Starting dynamic subtest: vecs0 [323.149506] Dynamic subtest vecs0: SUCCESS (4.922s) [323.157013] Starting dynamic subtest: ccs0 [341.158172] Dynamic subtest ccs0: SUCCESS (3.251s) [341.159119] Subtest preservation-S3: SUCCESS (19.636s) [347.423373] [023/131] (681s left) gem_exec_await (wide-contexts) [347.615279] Starting subtest: wide-contexts [371.442556] Subtest wide-contexts: SUCCESS (23.716s) [371.624297] [024/131] (657s left) kms_joiner (basic-ultra-joiner) [371.750093] Starting subtest: basic-ultra-joiner [371.751817] Subtest basic-ultra-joiner: SKIP (0.000s) [371.813738] [025/131] (657s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [371.909188] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [371.910180] Starting dynamic subtest: pipe-A-eDP-1 [371.919663] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [371.927818] Starting dynamic subtest: pipe-B-eDP-1 [371.936526] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [371.944058] Starting dynamic subtest: pipe-C-eDP-1 [371.952373] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [371.959669] Starting dynamic subtest: pipe-D-eDP-1 [371.968929] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [371.970812] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [374.114709] [026/131] (654s left) gem_softpin (allocator-basic-reserve) [374.170146] Starting subtest: allocator-basic-reserve [374.244323] Subtest allocator-basic-reserve: SUCCESS (0.073s) [374.385904] [027/131] (654s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [374.471745] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [374.472597] Starting dynamic subtest: pipe-A-eDP-1 [374.480787] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [374.488251] Starting dynamic subtest: pipe-B-eDP-1 [374.496545] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [374.504389] Starting dynamic subtest: pipe-C-eDP-1 [374.512388] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [374.519426] Starting dynamic subtest: pipe-D-eDP-1 [374.528997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [374.530986] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [376.705304] [028/131] (652s left) kms_prime (d3hot) [376.784556] Subtest D3hot: SKIP (0.000s) [376.862420] [029/131] (652s left) kms_big_fb (x-tiled-8bpp-rotate-0) [376.961877] Starting subtest: x-tiled-8bpp-rotate-0 [378.142939] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.181s) [378.237050] [030/131] (650s left) kms_psr (pr-sprite-mmap-cpu) [378.329434] Starting subtest: pr-sprite-mmap-cpu [378.331176] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [378.403766] [031/131] (650s left) gem_exec_basic (basic) [378.459119] Starting subtest: basic [378.460235] Starting dynamic subtest: rcs0-smem [378.462950] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [378.472231] Starting dynamic subtest: bcs0-smem [378.473113] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [378.480639] Starting dynamic subtest: vcs0-smem [378.481575] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [378.488808] Starting dynamic subtest: vcs1-smem [378.489759] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [378.496960] Starting dynamic subtest: vecs0-smem [378.497925] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [378.505152] Starting dynamic subtest: ccs0-smem [378.506055] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [378.506936] Subtest basic: SUCCESS (0.011s) [379.552963] [032/131] (649s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [379.644674] Starting subtest: fbc-rgb565-draw-render [383.861247] Subtest fbc-rgb565-draw-render: SUCCESS (4.218s) [385.009206] [033/131] (644s left) kms_big_fb (linear-16bpp-rotate-90) [385.107358] Starting subtest: linear-16bpp-rotate-90 [385.127168] Subtest linear-16bpp-rotate-90: SKIP (0.019s) [385.247206] [034/131] (644s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [385.331512] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [385.332323] Starting dynamic subtest: pipe-A-default-mode [385.617776] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [385.619642] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.285s) [386.422388] [035/131] (642s left) kms_big_fb (4-tiled-8bpp-rotate-270) [386.508537] Starting subtest: 4-tiled-8bpp-rotate-270 [386.528233] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.019s) [386.658457] [036/131] (642s left) gem_ctx_persistence (heartbeat-many) [386.715825] Starting subtest: heartbeat-many [386.717802] Subtest heartbeat-many: SKIP (0.000s) [386.830384] [037/131] (642s left) syncobj_timeline (wait-for-submit-delayed-submit) [386.872400] Starting subtest: wait-for-submit-delayed-submit [386.978811] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [387.051065] [038/131] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [387.147269] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [387.149004] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [387.257401] [039/131] (642s left) syncobj_wait (multi-wait-all-for-submit-submitted) [387.318069] Starting subtest: multi-wait-all-for-submit-submitted [387.424926] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [387.493628] [040/131] (642s left) gem_ctx_shared (q-promotion) [387.557269] Starting subtest: Q-promotion [387.558372] Starting dynamic subtest: rcs0 [387.666636] Dynamic subtest rcs0: SUCCESS (0.107s) [387.681723] Starting dynamic subtest: vcs0 [387.751642] Dynamic subtest vcs0: SUCCESS (0.085s) [387.767152] Starting dynamic subtest: vcs1 [387.829154] Dynamic subtest vcs1: SUCCESS (0.077s) [387.846552] Starting dynamic subtest: vecs0 [387.905833] Dynamic subtest vecs0: SUCCESS (0.074s) [387.920455] Starting dynamic subtest: ccs0 [387.985865] Dynamic subtest ccs0: SUCCESS (0.080s) [387.987306] Subtest Q-promotion: SUCCESS (0.428s) [389.671621] [041/131] (639s left) gem_exec_params (invalid-bsd1-flag-on-blt) [389.733962] Starting subtest: invalid-bsd1-flag-on-blt [389.734929] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [389.851269] [042/131] (639s left) kms_atomic_interruptible (universal-setplane-primary) [389.952021] Starting subtest: universal-setplane-primary [389.952914] Starting dynamic subtest: pipe-A-eDP-1 [397.336027] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.382s) [397.337128] Subtest universal-setplane-primary: SUCCESS (7.383s) [398.172745] [043/131] (631s left) gem_exec_balancer (full) [398.236118] Starting subtest: full [403.420482] Subtest full: SUCCESS (5.183s) [403.743264] [044/131] (625s left) kms_big_fb (yf-tiled-32bpp-rotate-270) [403.835129] Starting subtest: yf-tiled-32bpp-rotate-270 [403.836802] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s) [403.938832] [045/131] (625s left) syncobj_wait (reset-unsignaled) [403.979997] Starting subtest: reset-unsignaled [403.981932] Subtest reset-unsignaled: SUCCESS (0.000s) [404.074982] [046/131] (625s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [404.154454] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [404.156063] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [404.261107] [047/131] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [404.345992] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [404.347863] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [404.456121] [048/131] (625s left) kms_big_fb (y-tiled-addfb) [404.552611] Starting subtest: y-tiled-addfb [404.554401] Subtest y-tiled-addfb: SKIP (0.000s) [404.661826] [049/131] (625s left) gem_eio (wait-1us) [404.892110] Starting subtest: wait-1us [405.247930] Subtest wait-1us: SUCCESS (0.356s) [405.403317] [050/131] (624s left) core_setmaster (master-drop-set-user) [405.467740] Starting subtest: master-drop-set-user [405.480717] Subtest master-drop-set-user: SUCCESS (0.013s) [405.511055] [051/131] (624s left) gem_pwrite (basic-self) [405.557745] Subtest basic-self: SKIP (0.000s) [405.617125] [052/131] (624s left) gem_exec_reloc (basic-cpu-active) [405.680077] Subtest basic-cpu-active: SKIP (0.000s) [405.756210] [053/131] (624s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [410.777130] Starting subtest: pr-plane-move-sf-dmg-area [410.780121] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s) [411.619291] [054/131] (618s left) kms_cursor_crc (cursor-sliding-256x256) [411.857089] Starting subtest: cursor-sliding-256x256 [411.860532] Starting dynamic subtest: pipe-A-eDP-1 [415.110837] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.249s) [415.135919] Starting dynamic subtest: pipe-D-eDP-1 [419.011462] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.882s) [419.012515] Subtest cursor-sliding-256x256: SUCCESS (7.151s) [419.814874] [055/131] (610s left) kms_pm_dc (dc5-psr) [420.909833] Starting subtest: dc5-psr [423.790336] Subtest dc5-psr: SUCCESS (2.880s) [424.634529] [056/131] (605s left) gem_exec_schedule (pi-common) [424.821653] Starting subtest: pi-common [424.822840] Starting dynamic subtest: rcs0 [424.903411] Dynamic subtest rcs0: SUCCESS (0.083s) [424.914000] Starting dynamic subtest: bcs0 [424.984740] Dynamic subtest bcs0: SUCCESS (0.080s) [424.999640] Starting dynamic subtest: vcs0 [425.060625] Dynamic subtest vcs0: SUCCESS (0.075s) [425.076129] Starting dynamic subtest: vcs1 [425.136019] Dynamic subtest vcs1: SUCCESS (0.074s) [425.151841] Starting dynamic subtest: vecs0 [425.210841] Dynamic subtest vecs0: SUCCESS (0.074s) [425.225909] Starting dynamic subtest: ccs0 [425.285582] Dynamic subtest ccs0: SUCCESS (0.073s) [425.287172] Subtest pi-common: SUCCESS (0.466s) [425.529523] [057/131] (604s left) i915_query (query-regions-sanity-check) [425.574801] Starting subtest: query-regions-sanity-check [425.588395] Subtest query-regions-sanity-check: SUCCESS (0.014s) [425.690221] [058/131] (604s left) gem_mmap_offset (clear-via-pagefault) [425.743027] Starting subtest: clear-via-pagefault [425.743837] Starting dynamic subtest: smem0 [461.035795] Dynamic subtest smem0: SUCCESS (35.285s) [461.036959] Subtest clear-via-pagefault: SUCCESS (35.286s) [461.146814] [059/131] (568s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [461.240012] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [461.240953] Starting dynamic subtest: pipe-A-eDP-1 [461.996777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s) [462.006618] Starting dynamic subtest: pipe-B-eDP-1 [463.767805] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.770s) [463.776160] Starting dynamic subtest: pipe-C-eDP-1 [465.603984] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.835s) [465.612838] Starting dynamic subtest: pipe-D-eDP-1 [467.430841] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.827s) [467.431733] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.189s) [468.553217] [060/131] (561s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [468.639654] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [468.641778] Starting dynamic subtest: A-eDP1 [472.176437] Dynamic subtest A-eDP1: SUCCESS (3.534s) [472.185314] Starting dynamic subtest: B-eDP1 [475.374469] Dynamic subtest B-eDP1: SUCCESS (3.197s) [475.383257] Starting dynamic subtest: C-eDP1 [478.495216] Dynamic subtest C-eDP1: SUCCESS (3.119s) [478.509369] Starting dynamic subtest: D-eDP1 [481.601567] Dynamic subtest D-eDP1: SUCCESS (3.107s) [481.604496] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.964s) [482.404199] [061/131] (547s left) intel_hwmon (hwmon-write) [482.461691] Subtest hwmon-write: SKIP (0.000s) [482.519495] [062/131] (547s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [482.608332] Starting subtest: primary-y-tiled-reflect-x-90 [482.610056] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [482.678415] [063/131] (547s left) perf_pmu (rc6-all-gts) [482.711769] Starting subtest: rc6-all-gts [489.074933] Subtest rc6-all-gts: SUCCESS (6.359s) [489.457142] [064/131] (540s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [489.548363] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [489.549280] Starting dynamic subtest: pipe-A-eDP-1 [490.329940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.779s) [490.338345] Starting dynamic subtest: pipe-B-eDP-1 [491.865280] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s) [491.873494] Starting dynamic subtest: pipe-C-eDP-1 [493.347373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.480s) [493.355381] Starting dynamic subtest: pipe-D-eDP-1 [494.859220] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s) [494.860080] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.309s) [496.043119] [065/131] (534s left) gem_userptr_blits (create-destroy-sync) [496.104040] Starting subtest: create-destroy-sync [501.121181] Subtest create-destroy-sync: SUCCESS (5.014s) [501.261248] [066/131] (529s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [501.358778] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [501.360467] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [501.447043] [067/131] (528s left) gem_userptr_blits (sync-unmap) [501.507846] Starting subtest: sync-unmap [501.522597] Subtest sync-unmap: SUCCESS (0.014s) [501.649794] [068/131] (528s left) kms_cursor_crc (cursor-random-32x32) [501.795169] Starting subtest: cursor-random-32x32 [501.830710] Subtest cursor-random-32x32: SKIP (0.034s) [502.126853] [069/131] (528s left) kms_flip (2x-plain-flip) [502.217343] Starting subtest: 2x-plain-flip [502.226654] Subtest 2x-plain-flip: SKIP (0.011s) [502.299428] [070/131] (528s left) kms_vblank (wait-idle) [502.388393] Starting subtest: wait-idle [502.389368] Starting dynamic subtest: pipe-A-eDP-1 [504.161121] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.771s) [504.174943] Starting dynamic subtest: pipe-D-eDP-1 [506.577035] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.414s) [506.578012] Subtest wait-idle: SUCCESS (4.188s) [507.405891] [071/131] (523s left) gem_ctx_bad_destroy (invalid-default-ctx) [507.446547] Starting subtest: invalid-default-ctx [507.447492] Subtest invalid-default-ctx: SUCCESS (0.000s) [507.501867] [072/131] (523s left) perf (invalid-oa-metric-set-id) [507.588151] Starting subtest: invalid-oa-metric-set-id [507.596400] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s) [507.637093] [073/131] (522s left) gem_tiled_partial_pwrite_pread (reads) [507.685425] Subtest reads: SKIP (0.000s) [507.781529] [074/131] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [507.872643] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [512.535134] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.662s) [513.727951] [075/131] (516s left) kms_flip (2x-plain-flip-ts-check-interruptible) [513.825382] Starting subtest: 2x-plain-flip-ts-check-interruptible [513.836552] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s) [513.951364] [076/131] (516s left) gem_close_race (basic-process) [514.009467] Starting subtest: basic-process [514.090836] Subtest basic-process: SUCCESS (0.081s) [514.267316] [077/131] (516s left) kms_psr (fbc-pr-no-drrs) [514.355407] Starting subtest: fbc-pr-no-drrs [514.357096] Subtest fbc-pr-no-drrs: SKIP (0.000s) [514.420183] [078/131] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [514.508732] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [514.510367] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [514.610716] [079/131] (516s left) gem_eio (in-flight-contexts-1us) [514.830701] Starting subtest: in-flight-contexts-1us [526.541991] Subtest in-flight-contexts-1us: SUCCESS (11.708s) [526.716139] [080/131] (504s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [526.791819] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [526.792895] Starting dynamic subtest: pipe-A-eDP-1 [526.801608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [526.809803] Starting dynamic subtest: pipe-B-eDP-1 [526.817480] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [526.826255] Starting dynamic subtest: pipe-C-eDP-1 [526.833677] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [526.841778] Starting dynamic subtest: pipe-D-eDP-1 [526.849282] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [526.850112] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [528.982067] [081/131] (501s left) gem_lmem_swapping (heavy-verify-multi) [529.020496] Subtest heavy-verify-multi: SKIP (0.000s) [529.058259] [082/131] (501s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [529.148573] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [529.150401] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [529.237925] [083/131] (501s left) kms_async_flips (async-flip-dpms) [529.317088] Starting subtest: async-flip-dpms [529.688455] Starting dynamic subtest: pipe-A-eDP-1 [533.504694] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.815s) [533.873168] Starting dynamic subtest: pipe-B-eDP-1 [536.669414] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.805s) [537.045421] Starting dynamic subtest: pipe-C-eDP-1 [539.833396] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.795s) [540.214569] Starting dynamic subtest: pipe-D-eDP-1 [542.992056] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.786s) [542.993377] Subtest async-flip-dpms: SUCCESS (13.672s) [544.168740] [084/131] (486s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [544.255316] Starting subtest: psr-rgb565-draw-pwrite [551.268511] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.012s) [551.375899] [085/131] (479s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [551.482618] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [560.008570] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.525s) [560.114154] [086/131] (470s left) gem_ccs (block-multicopy-inplace) [560.181325] Starting subtest: block-multicopy-inplace [560.183396] Subtest block-multicopy-inplace: SKIP (0.000s) [560.287858] [087/131] (470s left) kms_dirtyfb (psr-dirtyfb-ioctl) [560.383414] Starting subtest: psr-dirtyfb-ioctl [560.384404] Starting dynamic subtest: A-eDP-1 [564.368055] Dynamic subtest A-eDP-1: SUCCESS (3.982s) [564.369016] Subtest psr-dirtyfb-ioctl: SUCCESS (3.984s) [565.170077] [088/131] (465s left) gem_mmap_gtt (hang-busy) [565.217771] Subtest hang-busy: SKIP (0.000s) [565.278743] [089/131] (465s left) prime_vgem (basic-blt) [565.359708] Starting subtest: basic-blt [565.392203] Subtest basic-blt: SUCCESS (0.034s) [565.519382] [090/131] (465s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [565.619371] Starting subtest: plane-all-modeset-transition-internal-panels [565.620215] Starting dynamic subtest: pipe-A-eDP-1 [566.130835] Dynamic subtest pipe-A-eDP-1: FAIL (0.294s) [566.139580] Starting dynamic subtest: pipe-B-eDP-1 [566.918900] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.000s) [567.189347] Subtest plane-all-modeset-transition-internal-panels: FAIL (1.569s) [568.019963] [091/131] (463s left) kms_big_fb (y-tiled-16bpp-rotate-90) [568.117482] Starting subtest: y-tiled-16bpp-rotate-90 [568.119160] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [568.220101] [092/131] (462s left) gem_exec_schedule (preempt-queue-contexts) [568.283529] Subtest preempt-queue-contexts: SKIP (0.000s) [568.576404] [093/131] (462s left) i915_hangman (engine-engine-hang) [568.643345] Starting subtest: engine-engine-hang [568.644228] Starting dynamic subtest: rcs0 [570.531174] Dynamic subtest rcs0: SUCCESS (1.884s) [570.543556] Starting dynamic subtest: bcs0 [572.513942] Dynamic subtest bcs0: SUCCESS (1.980s) [572.525569] Starting dynamic subtest: vcs0 [574.497700] Dynamic subtest vcs0: SUCCESS (1.983s) [574.509157] Starting dynamic subtest: vcs1 [576.482704] Dynamic subtest vcs1: SUCCESS (1.983s) [576.494040] Starting dynamic subtest: vecs0 [578.530843] Dynamic subtest vecs0: SUCCESS (2.046s) [578.542158] Starting dynamic subtest: ccs0 [580.514919] Dynamic subtest ccs0: SUCCESS (1.982s) [580.516469] Subtest engine-engine-hang: SUCCESS (11.871s) [580.591491] [094/131] (450s left) gem_render_copy (yf-tiled-to-vebox-linear) [580.640485] Starting subtest: yf-tiled-to-vebox-linear [580.642426] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [580.817936] [095/131] (450s left) gen9_exec_parse (allowed-single) [580.874262] Subtest allowed-single: SKIP (0.000s) [580.981154] [096/131] (450s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [581.070314] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [581.072038] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [581.157531] [097/131] (450s left) syncobj_wait (single-wait-signaled) [581.199608] Starting subtest: single-wait-signaled [581.200525] Subtest single-wait-signaled: SUCCESS (0.000s) [581.302607] [098/131] (450s left) kms_psr (fbc-psr-primary-mmap-cpu) [581.388453] Starting subtest: fbc-psr-primary-mmap-cpu [581.389426] Starting dynamic subtest: eDP-1 [581.391250] Dynamic subtest eDP-1: SKIP (0.000s) [581.392866] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [581.454983] [099/131] (450s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [581.568083] Starting subtest: basic-flip-before-cursor-varying-size [582.491860] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.922s) [583.348539] [100/131] (448s left) gem_softpin (invalid) [583.407767] Starting subtest: invalid [583.412483] Subtest invalid: SUCCESS (0.006s) [583.519102] [101/131] (448s left) kms_selftest (drm_plane_helper) [583.554287] Starting subtest: drm_plane_helper [583.570740] Starting dynamic subtest: drm_test_check_plane_state [583.714695] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.145s) [583.725259] Starting dynamic subtest: drm_test_check_invalid_plane_state [583.846364] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.130s) [583.847395] Subtest drm_plane_helper: SUCCESS (0.290s) [584.043459] [102/131] (447s left) kms_psr (fbc-psr2-cursor-plane-onoff) [584.131139] Starting subtest: fbc-psr2-cursor-plane-onoff [584.132095] Starting dynamic subtest: eDP-1 [584.133848] Dynamic subtest eDP-1: SKIP (0.000s) [584.135621] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [584.196462] [103/131] (447s left) kms_pipe_stress (stress-xrgb8888-ytiled) [584.292620] Starting subtest: stress-xrgb8888-ytiled [584.294450] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [584.371913] [104/131] (447s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [584.889602] Starting subtest: syncobj-stationary-timeline-chain-engines [585.010012] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.120s) [586.672429] [105/131] (444s left) gem_exec_gttfill (basic) [586.722276] Starting subtest: basic [590.489939] Subtest basic: SUCCESS (3.766s) [590.668010] [106/131] (441s left) kms_big_fb (x-tiled-32bpp-rotate-0) [590.802227] Starting subtest: x-tiled-32bpp-rotate-0 [592.125895] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.323s) [592.281517] [107/131] (439s left) kms_getfb (getfb2-handle-closed) [592.370227] Starting subtest: getfb2-handle-closed [592.371145] Subtest getfb2-handle-closed: SUCCESS (0.000s) [592.488273] [108/131] (439s left) kms_flip (flip-vs-expired-vblank-interruptible) [592.579033] Starting subtest: flip-vs-expired-vblank-interruptible [592.581283] Starting dynamic subtest: A-eDP1 [601.268613] Dynamic subtest A-eDP1: SUCCESS (8.688s) [601.279872] Starting dynamic subtest: B-eDP1 [609.893751] Dynamic subtest B-eDP1: SUCCESS (8.623s) [609.904648] Starting dynamic subtest: C-eDP1 [618.526241] Dynamic subtest C-eDP1: SUCCESS (8.631s) [618.537080] Starting dynamic subtest: D-eDP1 [627.140637] Dynamic subtest D-eDP1: SUCCESS (8.613s) [627.143018] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.566s) [628.312371] [109/131] (403s left) gem_exec_whisper (basic-contexts-forked) [628.369665] Starting subtest: basic-contexts-forked [652.914916] Subtest basic-contexts-forked: SUCCESS (24.541s) [653.089563] [110/131] (378s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [653.192404] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [653.193333] Starting dynamic subtest: pipe-A [653.208823] Dynamic subtest pipe-A: SKIP (0.015s) [653.217673] Starting dynamic subtest: pipe-B [653.234552] Dynamic subtest pipe-B: SKIP (0.026s) [653.243792] Starting dynamic subtest: pipe-C [653.263504] Dynamic subtest pipe-C: SKIP (0.027s) [653.271955] Starting dynamic subtest: pipe-D [653.289501] Dynamic subtest pipe-D: SKIP (0.026s) [653.291108] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.096s) [653.402554] [111/131] (378s left) gem_partial_pwrite_pread (write-uncached) [653.462180] Subtest write-uncached: SKIP (0.000s) [653.517549] [112/131] (378s left) vgem_basic (mmap) [653.556570] Starting subtest: mmap [653.590785] Subtest mmap: SUCCESS (0.035s) [653.646006] [113/131] (378s left) kms_psr (psr2-sprite-mmap-cpu) [653.727097] Starting subtest: psr2-sprite-mmap-cpu [653.727920] Starting dynamic subtest: eDP-1 [655.402034] Dynamic subtest eDP-1: SUCCESS (1.675s) [655.402954] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.675s) [656.274384] [114/131] (375s left) dmabuf_sync_file (export-multiwait) [656.309420] Starting subtest: export-multiwait [656.310434] Subtest export-multiwait: SUCCESS (0.000s) [656.362063] [115/131] (375s left) kms_chamelium_edid (dp-edid-resolution-list) [656.728684] Subtest dp-edid-resolution-list: SKIP (0.000s) [657.578672] [116/131] (374s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [657.675365] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [664.669117] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.994s) [664.787161] [117/131] (367s left) kms_plane (plane-position-hole) [664.882389] Starting subtest: plane-position-hole [665.375470] Starting dynamic subtest: pipe-A-plane-1 [666.624091] Dynamic subtest pipe-A-plane-1: SUCCESS (1.248s) [666.633328] Starting dynamic subtest: pipe-A-plane-2 [667.851503] Dynamic subtest pipe-A-plane-2: SUCCESS (1.226s) [667.862532] Starting dynamic subtest: pipe-A-plane-3 [669.093486] Dynamic subtest pipe-A-plane-3: SUCCESS (1.242s) [669.102545] Starting dynamic subtest: pipe-A-plane-4 [670.318851] Dynamic subtest pipe-A-plane-4: SUCCESS (1.224s) [670.329547] Starting dynamic subtest: pipe-A-plane-5 [670.346926] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s) [671.471042] Starting dynamic subtest: pipe-B-plane-1 [672.686712] Dynamic subtest pipe-B-plane-1: SUCCESS (1.222s) [672.697736] Starting dynamic subtest: pipe-B-plane-2 [673.923497] Dynamic subtest pipe-B-plane-2: SUCCESS (1.236s) [673.932264] Starting dynamic subtest: pipe-B-plane-3 [675.149025] Dynamic subtest pipe-B-plane-3: SUCCESS (1.225s) [675.158114] Starting dynamic subtest: pipe-B-plane-4 [676.414472] Dynamic subtest pipe-B-plane-4: SUCCESS (1.264s) [676.423868] Starting dynamic subtest: pipe-B-plane-5 [676.438433] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [676.439363] Subtest plane-position-hole: SUCCESS (11.556s) [677.290016] [118/131] (354s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [677.341762] Starting subtest: etime-single-wait-available-unsubmitted [677.448326] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s) [677.520808] [119/131] (354s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [677.616821] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [677.618865] Starting dynamic subtest: pipe-A-default-mode [678.739683] Dynamic subtest pipe-A-default-mode: SKIP (1.118s) [678.741446] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.121s) [678.901688] [120/131] (353s left) gem_spin_batch (resubmit-new) [678.962450] Starting subtest: resubmit-new [678.963470] Starting dynamic subtest: rcs0 [678.971425] Dynamic subtest rcs0: SUCCESS (0.009s) [678.980565] Starting dynamic subtest: bcs0 [678.981495] Dynamic subtest bcs0: SUCCESS (0.004s) [678.990221] Starting dynamic subtest: vcs0 [678.991148] Dynamic subtest vcs0: SUCCESS (0.004s) [678.999746] Starting dynamic subtest: vcs1 [679.000669] Dynamic subtest vcs1: SUCCESS (0.004s) [679.009058] Starting dynamic subtest: vecs0 [679.009925] Dynamic subtest vecs0: SUCCESS (0.004s) [679.018345] Starting dynamic subtest: ccs0 [679.019255] Dynamic subtest ccs0: SUCCESS (0.004s) [679.020109] Subtest resubmit-new: SUCCESS (0.033s) [680.548113] [121/131] (351s left) kms_sequence (get-idle) [680.629375] Starting subtest: get-idle [680.631485] Starting dynamic subtest: pipe-A-eDP-1 [682.453692] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.821s) [682.464029] Starting dynamic subtest: pipe-B-eDP-1 [684.877348] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.422s) [684.888841] Starting dynamic subtest: pipe-C-eDP-1 [687.298714] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.421s) [687.309200] Starting dynamic subtest: pipe-D-eDP-1 [689.727070] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.426s) [689.728003] Subtest get-idle: SUCCESS (9.096s) [690.529689] [122/131] (341s left) kms_cursor_legacy (torture-move) [690.644113] Starting subtest: torture-move [690.645025] Starting dynamic subtest: pipe-A [696.931863] Dynamic subtest pipe-A: SUCCESS (6.283s) [696.943089] Starting dynamic subtest: pipe-B [703.112615] Dynamic subtest pipe-B: SUCCESS (6.180s) [703.128453] Starting dynamic subtest: pipe-C [710.115037] Dynamic subtest pipe-C: SUCCESS (7.001s) [710.127698] Starting dynamic subtest: pipe-D [716.994356] Dynamic subtest pipe-D: SUCCESS (6.875s) [717.006039] Starting dynamic subtest: all-pipes [723.887694] Dynamic subtest all-pipes: SUCCESS (6.891s) [723.888897] Subtest torture-move: SUCCESS (33.237s) [724.039936] [123/131] (308s left) gem_exec_whisper (basic-forked-all) [724.098417] Starting subtest: basic-forked-all [737.542350] Subtest basic-forked-all: SUCCESS (13.438s) [737.720892] [124/131] (294s left) kms_lease (possible-crtcs-filtering) [737.821196] Starting subtest: possible-crtcs-filtering [737.825852] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [737.947792] [125/131] (294s left) kms_cursor_crc (cursor-offscreen-512x170) [738.245127] Starting subtest: cursor-offscreen-512x170 [738.246840] Subtest cursor-offscreen-512x170: SKIP (0.001s) [738.400758] [126/131] (293s left) gen9_exec_parse (cmd-crossing-page) [738.458853] Subtest cmd-crossing-page: SKIP (0.000s) [738.541370] [127/131] (293s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [738.592425] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [738.696788] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s) [738.763721] [128/131] (293s left) sw_sync (alloc_fence_invalid_timeline) [738.791158] Starting subtest: alloc_fence_invalid_timeline [738.792130] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [738.842332] [129/131] (293s left) kms_frontbuffer_tracking (fbc-stridechange) [738.945185] Starting subtest: fbc-stridechange [742.314753] Subtest fbc-stridechange: SUCCESS (3.370s) [743.451554] [130/131] (289s left) kms_flip (flip-vs-panning-vs-hang) [743.548279] Starting subtest: flip-vs-panning-vs-hang [743.549209] Starting dynamic subtest: A-eDP1 [795.052705] Dynamic subtest A-eDP1: SUCCESS (51.493s) [795.064780] Starting dynamic subtest: D-eDP1 [835.046314] Dynamic subtest D-eDP1: SUCCESS (39.988s) [835.047331] Subtest flip-vs-panning-vs-hang: SUCCESS (91.486s) [836.223551] [131/131] (196s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [836.319356] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [843.633959] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.319s) [843.805642] Closing watchdogs results: parsing output: 0/ for test: perf results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: kms_chamelium_frames results: parsing output: 3/ for test: sysfs_timeslice_duration results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: gem_set_tiling_vs_pwrite results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: i915_hangman results: parsing output: 8/ for test: perf results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_properties results: parsing output: 11/ for test: kms_cursor_legacy results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_addfb_basic results: parsing output: 14/ for test: gem_exec_fence results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_color results: parsing output: 17/ for test: kms_plane_multiple results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: gem_ctx_isolation results: parsing output: 22/ for test: gem_exec_await results: parsing output: 23/ for test: kms_joiner results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: gem_softpin results: parsing output: 26/ for test: kms_ccs results: parsing output: 27/ for test: kms_prime results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: gem_exec_basic results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: kms_flip_scaled_crc results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_ctx_persistence results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: gem_ctx_shared results: parsing output: 40/ for test: gem_exec_params results: parsing output: 41/ for test: kms_atomic_interruptible results: parsing output: 42/ for test: gem_exec_balancer results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: syncobj_wait results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_eio results: parsing output: 49/ for test: core_setmaster results: parsing output: 50/ for test: gem_pwrite results: parsing output: 51/ for test: gem_exec_reloc results: parsing output: 52/ for test: kms_psr2_sf results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_pm_dc results: parsing output: 55/ for test: gem_exec_schedule results: parsing output: 56/ for test: i915_query results: parsing output: 57/ for test: gem_mmap_offset results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: intel_hwmon results: parsing output: 61/ for test: kms_rotation_crc results: parsing output: 62/ for test: perf_pmu results: parsing output: 63/ for test: kms_ccs results: parsing output: 64/ for test: gem_userptr_blits results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_userptr_blits results: parsing output: 67/ for test: kms_cursor_crc results: parsing output: 68/ for test: kms_flip results: parsing output: 69/ for test: kms_vblank results: parsing output: 70/ for test: gem_ctx_bad_destroy results: parsing output: 71/ for test: perf results: parsing output: 72/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: gem_close_race results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_eio results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: gem_lmem_swapping results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_async_flips results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_ccs results: parsing output: 86/ for test: kms_dirtyfb results: parsing output: 87/ for test: gem_mmap_gtt results: parsing output: 88/ for test: prime_vgem results: parsing output: 89/ for test: kms_atomic_transition results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: gem_exec_schedule results: parsing output: 92/ for test: i915_hangman results: parsing output: 93/ for test: gem_render_copy results: parsing output: 94/ for test: gen9_exec_parse results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: syncobj_wait results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: gem_softpin results: parsing output: 100/ for test: kms_selftest results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_pipe_stress results: parsing output: 103/ for test: gem_exec_fence results: parsing output: 104/ for test: gem_exec_gttfill results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_getfb results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: gem_exec_whisper results: parsing output: 109/ for test: kms_plane_scaling results: parsing output: 110/ for test: gem_partial_pwrite_pread results: parsing output: 111/ for test: vgem_basic results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: kms_chamelium_edid results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_plane results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: kms_flip_scaled_crc results: parsing output: 119/ for test: gem_spin_batch results: parsing output: 120/ for test: kms_sequence results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: gem_exec_whisper results: parsing output: 123/ for test: kms_lease results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: gen9_exec_parse results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: sw_sync results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.