[61.702438] Initializing watchdogs
[61.702522]   /dev/watchdog0
[61.732929] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[61.747866] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.753154] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.755880] [001/132] (960s left) syncobj_wait (multi-wait-all-submitted)
[61.804892] Starting subtest: multi-wait-all-submitted
[61.915358] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[62.047014] [002/132] (960s left) gem_exec_reloc (basic-concurrent16)
[62.101124] Subtest basic-concurrent16: SKIP (0.000s)
[62.197442] [003/132] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[63.683899] Starting subtest: primary-yf-tiled-reflect-x-0
[63.794501] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.109s)
[63.994786] [004/132] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[65.487286] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[65.489266] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[65.687715] [005/132] (956s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[67.173402] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[67.175484] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[67.272411] [006/132] (955s left) kms_psr (fbc-pr-no-drrs)
[68.762865] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[68.914831] [007/132] (953s left) sw_sync (alloc_fence)
[68.975442] Starting subtest: alloc_fence
[68.976294] Subtest alloc_fence: SUCCESS (0.000s)
[69.095304] [008/132] (953s left) gem_eio (wait-10ms)
[69.228375] Starting subtest: wait-10ms
[69.612874] Subtest wait-10ms: SUCCESS (0.385s)
[71.259856] [009/132] (951s left) gem_wait (await)
[71.519092] Starting subtest: await
[71.520241] Starting dynamic subtest: all-engines
[72.661174] Dynamic subtest all-engines: SUCCESS (1.143s)
[72.679641] Starting dynamic subtest: rcs0
[73.723772] Dynamic subtest rcs0: SUCCESS (1.061s)
[73.736651] Starting dynamic subtest: bcs0
[74.785792] Dynamic subtest bcs0: SUCCESS (1.061s)
[74.823537] Starting dynamic subtest: vcs0
[75.862759] Dynamic subtest vcs0: SUCCESS (1.075s)
[75.875692] Starting dynamic subtest: vcs1
[76.925710] Dynamic subtest vcs1: SUCCESS (1.061s)
[76.964896] Starting dynamic subtest: vecs0
[78.002740] Dynamic subtest vecs0: SUCCESS (1.076s)
[78.004828] Subtest await: SUCCESS (6.485s)
[78.346166] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[78.348056] [010/132] (944s left) gem_exec_schedule (u-semaphore-user)
[78.407547] Starting subtest: u-semaphore-user
[78.438678] Subtest u-semaphore-user: SUCCESS (0.031s)
[78.850761] [011/132] (944s left) kms_getfb (getfb2-handle-not-fb)
[80.335995] Starting subtest: getfb2-handle-not-fb
[80.336954] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[80.499913] [012/132] (942s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[82.012970] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[82.088977] [013/132] (941s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[82.137028] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[82.250559] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[82.409630] [014/132] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[83.899415] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[83.901161] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[84.152583] [015/132] (939s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[85.641598] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[85.720688] [016/132] (938s left) kms_properties (crtc-properties-legacy)
[87.207454] Starting subtest: crtc-properties-legacy
[87.209574] Starting dynamic subtest: pipe-A-HDMI-A-3
[87.499035] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.290s)
[87.509157] Starting dynamic subtest: pipe-B-HDMI-A-3
[87.778089] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.277s)
[87.787761] Starting dynamic subtest: pipe-C-HDMI-A-3
[88.067046] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.288s)
[88.075760] Starting dynamic subtest: pipe-D-HDMI-A-3
[88.341040] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.272s)
[88.341962] Subtest crtc-properties-legacy: SUCCESS (1.133s)
[88.521514] [017/132] (935s left) kms_chamelium_frames (hdmi-aspect-ratio)
[90.047901] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[90.161876] [018/132] (933s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[91.645832] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[91.647734] Starting dynamic subtest: pipe-A-HDMI-A-3
[91.655680] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[91.664377] Starting dynamic subtest: pipe-B-HDMI-A-3
[91.672456] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[91.681096] Starting dynamic subtest: pipe-C-HDMI-A-3
[91.689160] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[91.698203] Starting dynamic subtest: pipe-D-HDMI-A-3
[91.706602] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[91.708199] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[91.912094] [019/132] (932s left) gem_ctx_param (basic-default)
[91.958088] Starting subtest: basic-default
[91.959033] Subtest basic-default: SUCCESS (0.000s)
[92.063681] [020/132] (931s left) gem_exec_whisper (basic-queues-forked)
[92.120285] Starting subtest: basic-queues-forked
[107.854815] Subtest basic-queues-forked: SUCCESS (15.732s)
[108.078138] [021/132] (916s left) dmabuf_sync_file (import-basic)
[108.129454] Starting subtest: import-basic
[108.131945] Subtest import-basic: SUCCESS (0.003s)
[108.225093] [022/132] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[109.714824] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[109.716581] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[109.931852] [023/132] (914s left) kms_addfb_basic (master-rmfb)
[109.976243] Starting subtest: master-rmfb
[109.977185] Subtest master-rmfb: SUCCESS (0.001s)
[111.612446] [024/132] (912s left) gem_ctx_exec (basic-norecovery)
[111.658288] Starting subtest: basic-norecovery
[111.953954] Subtest basic-norecovery: SUCCESS (0.296s)
[112.164687] [025/132] (912s left) i915_pm_rps (basic-api)
[112.216921] Starting subtest: basic-api
[112.218604] Subtest basic-api: SKIP (0.001s)
[112.327530] [026/132] (912s left) gem_ctx_param (set-priority-not-supported)
[112.369971] Starting subtest: set-priority-not-supported
[112.371652] Subtest set-priority-not-supported: SKIP (0.000s)
[112.537016] [027/132] (912s left) kms_rotation_crc (exhaust-fences)
[114.020644] Starting subtest: exhaust-fences
[114.022319] Subtest exhaust-fences: SKIP (0.000s)
[114.137165] [028/132] (910s left) kms_flip (flip-vs-blocking-wf-vblank)
[115.632575] Starting subtest: flip-vs-blocking-wf-vblank
[115.639126] Starting dynamic subtest: A-HDMI-A3
[123.828809] Dynamic subtest A-HDMI-A3: SUCCESS (8.190s)
[123.839936] Starting dynamic subtest: B-HDMI-A3
[131.794578] Dynamic subtest B-HDMI-A3: SUCCESS (7.965s)
[131.804104] Starting dynamic subtest: C-HDMI-A3
[139.764470] Dynamic subtest C-HDMI-A3: SUCCESS (7.969s)
[139.774038] Starting dynamic subtest: D-HDMI-A3
[147.736797] Dynamic subtest D-HDMI-A3: SUCCESS (7.971s)
[147.744084] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.111s)
[147.996603] [029/132] (876s left) kms_sequence (queue-idle)
[149.480874] Starting subtest: queue-idle
[149.482936] Starting dynamic subtest: pipe-A-HDMI-A-3
[151.899913] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.418s)
[151.910302] Starting dynamic subtest: pipe-B-HDMI-A-3
[154.114182] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.212s)
[154.124537] Starting dynamic subtest: pipe-C-HDMI-A-3
[156.334304] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.218s)
[156.344549] Starting dynamic subtest: pipe-D-HDMI-A-3
[158.560510] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.224s)
[158.561276] Subtest queue-idle: SUCCESS (9.078s)
[158.746130] [030/132] (866s left) kms_plane_multiple (2x-tiling-x)
[160.233097] Starting subtest: 2x-tiling-x
[160.235050] Subtest 2x-tiling-x: SKIP (0.000s)
[160.369845] [031/132] (864s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[160.427269] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[160.538636] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[160.672579] [032/132] (864s left) gem_exec_store (basic)
[160.727739] Starting subtest: basic
[160.831733] Subtest basic: SUCCESS (0.105s)
[161.127671] [033/132] (864s left) prime_vgem (fence-read-hang)
[161.190298] Subtest fence-read-hang: SKIP (0.000s)
[161.406249] [034/132] (863s left) kms_busy (extended-modeset-hang-newfb)
[162.898221] Starting subtest: extended-modeset-hang-newfb
[162.899232] Starting dynamic subtest: pipe-A
[178.486842] Dynamic subtest pipe-A: SUCCESS (15.586s)
[178.499202] Starting dynamic subtest: pipe-D
[194.021210] Dynamic subtest pipe-D: SUCCESS (15.528s)
[194.022171] Subtest extended-modeset-hang-newfb: SUCCESS (31.122s)
[194.224360] [035/132] (831s left) sysfs_heartbeat_interval (idempotent)
[194.274939] Starting subtest: idempotent
[194.275848] Starting dynamic subtest: vecs0
[194.276691] Dynamic subtest vecs0: SUCCESS (0.001s)
[194.286115] Starting dynamic subtest: vcs0
[194.287225] Dynamic subtest vcs0: SUCCESS (0.001s)
[194.296484] Starting dynamic subtest: bcs0
[194.297617] Dynamic subtest bcs0: SUCCESS (0.001s)
[194.306664] Starting dynamic subtest: rcs0
[194.307774] Dynamic subtest rcs0: SUCCESS (0.001s)
[194.316889] Starting dynamic subtest: vcs1
[194.318038] Dynamic subtest vcs1: SUCCESS (0.001s)
[194.319216] Subtest idempotent: SUCCESS (0.008s)
[194.452640] [036/132] (831s left) perf (invalid-oa-metric-set-id)
[194.575931] Starting subtest: invalid-oa-metric-set-id
[194.598289] Subtest invalid-oa-metric-set-id: SUCCESS (0.023s)
[194.673600] [037/132] (830s left) kms_cursor_crc (cursor-random-256x256)
[196.386855] Starting subtest: cursor-random-256x256
[196.391995] Starting dynamic subtest: pipe-A-HDMI-A-3
[200.683585] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.290s)
[200.718160] Starting dynamic subtest: pipe-D-HDMI-A-3
[205.184364] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.474s)
[205.185210] Subtest cursor-random-256x256: SUCCESS (8.798s)
[205.541438] [038/132] (820s left) i915_query (query-regions-unallocated)
[205.586205] Starting subtest: query-regions-unallocated
[206.035047] Subtest query-regions-unallocated: SUCCESS (0.450s)
[206.143456] [039/132] (819s left) gem_pread (self)
[206.187799] Subtest self: SKIP (0.000s)
[206.289980] [040/132] (819s left) kms_cursor_legacy (single-move)
[207.775852] Starting subtest: single-move
[207.776719] Starting dynamic subtest: pipe-A
[213.163453] Dynamic subtest pipe-A: SUCCESS (5.383s)
[213.172967] Starting dynamic subtest: pipe-B
[218.545504] Dynamic subtest pipe-B: SUCCESS (5.381s)
[218.554976] Starting dynamic subtest: pipe-C
[223.927475] Dynamic subtest pipe-C: SUCCESS (5.381s)
[223.936845] Starting dynamic subtest: pipe-D
[229.309873] Dynamic subtest pipe-D: SUCCESS (5.381s)
[229.319349] Starting dynamic subtest: all-pipes
[234.692481] Dynamic subtest all-pipes: SUCCESS (5.382s)
[234.693452] Subtest single-move: SUCCESS (26.911s)
[234.792398] [041/132] (791s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[236.302581] Starting subtest: 4-tiled-32bpp-rotate-0
[236.304669] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[236.454208] [042/132] (789s left) kms_pm_backlight (fade-with-suspend)
[237.959956] Subtest fade-with-suspend: SKIP (0.000s)
[238.034725] [043/132] (787s left) kms_flip (2x-flip-vs-expired-vblank)
[239.520089] Starting subtest: 2x-flip-vs-expired-vblank
[239.539689] Subtest 2x-flip-vs-expired-vblank: SKIP (0.019s)
[239.686564] [044/132] (786s left) perf_pmu (most-busy-check-all)
[239.737214] Starting subtest: most-busy-check-all
[239.738133] Starting dynamic subtest: rcs0
[240.308258] Dynamic subtest rcs0: SUCCESS (0.571s)
[240.321697] Starting dynamic subtest: bcs0
[240.857264] Dynamic subtest bcs0: SUCCESS (0.548s)
[240.869581] Starting dynamic subtest: vcs0
[241.405208] Dynamic subtest vcs0: SUCCESS (0.547s)
[241.417461] Starting dynamic subtest: vcs1
[241.954447] Dynamic subtest vcs1: SUCCESS (0.548s)
[241.966712] Starting dynamic subtest: vecs0
[242.503303] Dynamic subtest vecs0: SUCCESS (0.548s)
[242.504337] Subtest most-busy-check-all: SUCCESS (2.766s)
[242.691538] [045/132] (783s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[244.181358] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[247.461415] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.279s)
[247.637611] [046/132] (778s left) kms_hdr (static-toggle)
[249.121708] Starting subtest: static-toggle
[249.124363] Subtest static-toggle: SKIP (0.001s)
[249.235924] [047/132] (777s left) kms_big_fb (x-tiled-addfb-size-overflow)
[250.753132] Starting subtest: x-tiled-addfb-size-overflow
[250.755171] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.002s)
[250.958309] [048/132] (775s left) gem_exec_balancer (bonded-chain)
[251.013327] Starting subtest: bonded-chain
[259.181650] Subtest bonded-chain: SUCCESS (8.164s)
[259.688400] [049/132] (766s left) gem_exec_reloc (basic-wc-cpu)
[259.739264] Subtest basic-wc-cpu: SKIP (0.000s)
[259.850540] [050/132] (766s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[261.336029] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[261.336914] Starting dynamic subtest: pipe-A-HDMI-A-3
[263.771814] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.428s)
[263.806677] Starting dynamic subtest: pipe-B-HDMI-A-3
[264.712676] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.932s)
[264.746904] Starting dynamic subtest: pipe-C-HDMI-A-3
[265.638101] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.917s)
[265.672199] Starting dynamic subtest: pipe-D-HDMI-A-3
[266.563808] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.916s)
[266.566108] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (5.222s)
[266.808058] [051/132] (759s left) gem_userptr_blits (forbidden-operations)
[266.862322] Starting subtest: forbidden-operations
[266.864582] Subtest forbidden-operations: SKIP (0.000s)
[267.055676] [052/132] (759s left) perf_pmu (busy-accuracy-98)
[267.103703] Starting subtest: busy-accuracy-98
[267.104672] Starting dynamic subtest: rcs0
[270.151202] Dynamic subtest rcs0: SUCCESS (3.046s)
[270.161835] Starting dynamic subtest: bcs0
[273.199302] Dynamic subtest bcs0: SUCCESS (3.047s)
[273.210126] Starting dynamic subtest: vcs0
[276.245294] Dynamic subtest vcs0: SUCCESS (3.045s)
[276.256172] Starting dynamic subtest: vcs1
[279.292030] Dynamic subtest vcs1: SUCCESS (3.046s)
[279.303368] Starting dynamic subtest: vecs0
[282.338939] Dynamic subtest vecs0: SUCCESS (3.047s)
[282.339849] Subtest busy-accuracy-98: SUCCESS (15.235s)
[282.530277] [053/132] (744s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[284.014894] Starting subtest: cursorB-vs-flipA-varying-size
[284.018960] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[284.134468] [054/132] (742s left) gem_workarounds (suspend-resume-fd)
[284.217795] Starting subtest: suspend-resume-fd
[309.910101] Subtest suspend-resume-fd: SUCCESS (10.207s)
[315.112747] [055/132] (716s left) gem_mmap_offset (partial-remap)
[315.160030] Starting subtest: partial-remap
[315.160925] Starting dynamic subtest: lmem0
[315.166091] Dynamic subtest lmem0: SUCCESS (0.006s)
[315.179499] Starting dynamic subtest: smem0
[315.181448] Dynamic subtest smem0: SUCCESS (0.005s)
[315.182318] Subtest partial-remap: SUCCESS (0.013s)
[315.311851] [056/132] (716s left) gem_ctx_engines (execute-oneforall)
[315.366305] Starting subtest: execute-oneforall
[316.005619] Subtest execute-oneforall: SUCCESS (0.635s)
[316.462259] [057/132] (715s left) kms_plane (plane-panning-top-left)
[317.948329] Starting subtest: plane-panning-top-left
[317.949348] Starting dynamic subtest: pipe-A
[318.638375] Dynamic subtest pipe-A: SUCCESS (0.689s)
[318.652156] Starting dynamic subtest: pipe-B
[319.187991] Dynamic subtest pipe-B: SUCCESS (0.547s)
[319.188873] Subtest plane-panning-top-left: SUCCESS (1.240s)
[319.385060] [058/132] (712s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[320.891890] Starting subtest: yf-tiled-addfb-size-offset-overflow
[320.893656] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[321.045721] [059/132] (711s left) gem_ccs (block-multicopy-compressed)
[321.099127] Starting subtest: block-multicopy-compressed
[321.100871] Subtest block-multicopy-compressed: SKIP (0.000s)
[321.225908] [060/132] (711s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[322.711669] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[322.714198] Starting dynamic subtest: pipe-A-HDMI-A-3
[322.718191] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[322.730550] Starting dynamic subtest: pipe-B-HDMI-A-3
[322.734516] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[322.746696] Starting dynamic subtest: pipe-C-HDMI-A-3
[322.750036] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[322.761979] Starting dynamic subtest: pipe-D-HDMI-A-3
[322.765845] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[322.767700] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[322.981222] [061/132] (709s left) gen9_exec_parse (bb-start-far)
[323.031261] Subtest bb-start-far: SKIP (0.000s)
[323.107853] [062/132] (709s left) prime_vgem (basic-fence-flip)
[323.198702] Starting subtest: basic-fence-flip
[324.672179] Subtest basic-fence-flip: SKIP (1.472s)
[324.893665] [063/132] (707s left) syncobj_timeline (invalid-wait-bad-flags)
[324.938176] Starting subtest: invalid-wait-bad-flags
[324.939089] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[325.069329] [064/132] (707s left) kms_vblank (ts-continuation-dpms-suspend)
[326.554943] Starting subtest: ts-continuation-dpms-suspend
[326.557162] Starting dynamic subtest: pipe-A-HDMI-A-3
[352.394853] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (10.461s)
[352.410033] Starting dynamic subtest: pipe-D-HDMI-A-3
[379.390091] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (10.104s)
[379.390994] Subtest ts-continuation-dpms-suspend: SUCCESS (20.571s)
[385.574741] [065/132] (653s left) kms_draw_crc (draw-method-mmap-cpu)
[387.062386] Starting subtest: draw-method-mmap-cpu
[387.063264] Starting dynamic subtest: xrgb8888-untiled
[387.427975] Dynamic subtest xrgb8888-untiled: SUCCESS (0.364s)
[387.471912] Starting dynamic subtest: rgb565-untiled
[387.761194] Dynamic subtest rgb565-untiled: SUCCESS (0.329s)
[387.806619] Starting dynamic subtest: xrgb2101010-untiled
[388.094674] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.329s)
[388.141081] Starting dynamic subtest: xbgr16161616f-untiled
[388.428014] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.329s)
[388.448565] Starting dynamic subtest: xrgb8888-xtiled
[388.594996] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.162s)
[388.641304] Starting dynamic subtest: rgb565-xtiled
[388.778041] Dynamic subtest rgb565-xtiled: SUCCESS (0.179s)
[388.798927] Starting dynamic subtest: xrgb2101010-xtiled
[388.927821] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.145s)
[388.976624] Starting dynamic subtest: xbgr16161616f-xtiled
[389.127832] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.195s)
[389.175907] Starting dynamic subtest: xrgb8888-ytiled
[389.327970] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.195s)
[389.375566] Starting dynamic subtest: rgb565-ytiled
[389.528064] Dynamic subtest rgb565-ytiled: SUCCESS (0.195s)
[389.572286] Starting dynamic subtest: xrgb2101010-ytiled
[389.711233] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.179s)
[389.756699] Starting dynamic subtest: xbgr16161616f-ytiled
[389.909883] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.195s)
[389.910943] Subtest draw-method-mmap-cpu: SUCCESS (2.848s)
[390.051373] [066/132] (648s left) kms_lease (simple-lease)
[391.542519] Starting subtest: simple-lease
[391.545147] Starting dynamic subtest: pipe-A-HDMI-A-3
[391.951411] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.407s)
[391.965192] Starting dynamic subtest: pipe-B-HDMI-A-3
[392.221012] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.267s)
[392.234605] Starting dynamic subtest: pipe-C-HDMI-A-3
[392.513129] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.290s)
[392.526900] Starting dynamic subtest: pipe-D-HDMI-A-3
[392.809129] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.294s)
[392.810015] Subtest simple-lease: SUCCESS (1.267s)
[392.998424] [067/132] (646s left) gem_exec_schedule (implicit-read-write)
[393.057787] Starting subtest: implicit-read-write
[393.058773] Starting dynamic subtest: rcs0
[393.257882] Dynamic subtest rcs0: SUCCESS (0.195s)
[393.270456] Starting dynamic subtest: bcs0
[393.388053] Dynamic subtest bcs0: SUCCESS (0.133s)
[393.400662] Starting dynamic subtest: vcs0
[393.525984] Dynamic subtest vcs0: SUCCESS (0.137s)
[393.539845] Starting dynamic subtest: vcs1
[393.665747] Dynamic subtest vcs1: SUCCESS (0.139s)
[393.679648] Starting dynamic subtest: vecs0
[393.814752] Dynamic subtest vecs0: SUCCESS (0.148s)
[393.815630] Subtest implicit-read-write: SUCCESS (0.758s)
[394.269130] [068/132] (644s left) prime_mmap (test_forked)
[394.313844] Starting subtest: test_forked
[394.314768] Starting dynamic subtest: test_forked-smem
[394.388509] Dynamic subtest test_forked-smem: SUCCESS (0.074s)
[394.400959] Starting dynamic subtest: test_forked-lmem0
[394.464050] Dynamic subtest test_forked-lmem0: SUCCESS (0.074s)
[394.465007] Subtest test_forked: SUCCESS (0.151s)
[394.605663] [069/132] (644s left) kms_frontbuffer_tracking (psr-2p-rte)
[396.099014] Starting subtest: psr-2p-rte
[396.100945] Subtest psr-2p-rte: SKIP (0.000s)
[396.274709] [070/132] (643s left) i915_drm_fdinfo (busy-idle)
[396.324601] Starting subtest: busy-idle
[396.325559] Starting dynamic subtest: rcs0
[396.327316] Dynamic subtest rcs0: SKIP (0.000s)
[396.340100] Starting dynamic subtest: bcs0
[396.342408] Dynamic subtest bcs0: SKIP (0.001s)
[396.354898] Starting dynamic subtest: vcs0
[396.357334] Dynamic subtest vcs0: SKIP (0.000s)
[396.369593] Starting dynamic subtest: vcs1
[396.372162] Dynamic subtest vcs1: SKIP (0.000s)
[396.386076] Starting dynamic subtest: vecs0
[396.388514] Dynamic subtest vecs0: SKIP (0.000s)
[396.390821] Subtest busy-idle: SKIP (0.007s)
[396.455532] [071/132] (642s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[397.947780] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[397.949464] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[398.129384] [072/132] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[399.621554] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[399.623265] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[399.822103] [073/132] (639s left) i915_module_load (reload)
[399.863952] Starting subtest: reload
[404.178629] Subtest reload: SUCCESS (4.315s)
[404.252633] [074/132] (635s left) api_intel_bb (object-reloc-purge-cache)
[404.344237] Starting subtest: object-reloc-purge-cache
[404.348897] Subtest object-reloc-purge-cache: SKIP (0.003s)
[404.520644] [075/132] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[406.012988] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[406.014972] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[406.206537] [076/132] (633s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[407.693281] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[407.694265] Starting dynamic subtest: pipe-A-valid-mode
[410.221496] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.526s)
[410.222321] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (2.529s)
[410.398048] [077/132] (629s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[411.888672] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[411.909488] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.020s)
[412.055167] [078/132] (628s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[413.546756] Starting subtest: fbc-rgb565-draw-pwrite
[416.531590] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.984s)
[416.775942] [079/132] (623s left) gem_lmem_swapping (random-engines)
[420.977334] Starting subtest: random-engines
[420.978387] Starting dynamic subtest: lmem0
[422.214251] Dynamic subtest lmem0: SUCCESS (1.233s)
[422.215299] Subtest random-engines: SUCCESS (1.234s)
[424.803202] [FACT gem_lmem_swapping (random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[424.804368] [FACT gem_lmem_swapping (random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[424.806733] [080/132] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[429.613672] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[429.615758] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[429.860485] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[429.863986] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[429.871750] [081/132] (610s left) syncobj_timeline (reset-signaled)
[429.918266] Starting subtest: reset-signaled
[429.919073] Subtest reset-signaled: SUCCESS (0.000s)
[430.030347] [082/132] (610s left) kms_pm_backlight (bad-brightness)
[431.517537] Subtest bad-brightness: SKIP (0.000s)
[431.591873] [083/132] (608s left) gem_exec_flush (basic-batch-kernel-default-uc)
[431.647248] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[431.743538] [084/132] (608s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[433.228001] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[433.247988] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.019s)
[433.375256] [085/132] (607s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[434.868676] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[434.870300] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[435.035170] [086/132] (605s left) kms_psr (fbc-psr-primary-blt)
[436.522417] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[436.593426] [087/132] (604s left) gem_render_copy (y-tiled-ccs-to-linear)
[436.647030] Starting subtest: y-tiled-ccs-to-linear
[436.647948] Starting dynamic subtest: smem
[436.742672] Dynamic subtest smem: SUCCESS (0.095s)
[436.755182] Starting dynamic subtest: lmem0
[437.057773] Dynamic subtest lmem0: SUCCESS (0.309s)
[437.059081] Subtest y-tiled-ccs-to-linear: SUCCESS (0.407s)
[437.319771] [088/132] (603s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[438.805084] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[438.807377] Starting dynamic subtest: pipe-A-HDMI-A-3
[438.816014] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[438.827098] Starting dynamic subtest: pipe-B-HDMI-A-3
[438.835886] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[438.846784] Starting dynamic subtest: pipe-C-HDMI-A-3
[438.855845] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[438.866446] Starting dynamic subtest: pipe-D-HDMI-A-3
[438.875300] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[438.876897] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[439.068046] [089/132] (601s left) gem_exec_create (legacy)
[439.125014] Starting subtest: legacy
[439.125964] Starting dynamic subtest: smem
[441.228970] Dynamic subtest smem: SUCCESS (2.103s)
[441.242093] Starting dynamic subtest: lmem0
[443.330705] Dynamic subtest lmem0: SUCCESS (2.100s)
[443.331813] Subtest legacy: SUCCESS (4.206s)
[443.606626] [090/132] (597s left) gem_mmap_gtt (basic-small-bo-tiledy)
[443.650880] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[443.727404] [091/132] (597s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[443.775673] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[443.887532] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[444.031721] [092/132] (597s left) gem_ctx_persistence (heartbeat-stop)
[444.083491] Starting subtest: heartbeat-stop
[444.085426] Subtest heartbeat-stop: SKIP (0.000s)
[444.202179] [093/132] (597s left) gem_spin_batch (user-each)
[444.259729] Starting subtest: user-each
[447.545493] Subtest user-each: SUCCESS (3.285s)
[447.905285] [094/132] (593s left) kms_chamelium_hpd (vga-hpd-fast)
[449.440894] Subtest vga-hpd-fast: SKIP (0.000s)
[449.560658] [095/132] (591s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[451.050187] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[453.797956] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.746s)
[454.001484] [096/132] (587s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[455.487234] Starting subtest: cursorA-vs-flipA-legacy
[466.403874] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.916s)
[466.579737] [097/132] (575s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[467.150400] Starting subtest: syncobj-timeline-multiple-ext-nodes
[467.151454] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.002s)
[467.474929] [098/132] (574s left) sw_sync (sync_expired_merge)
[467.517898] Starting subtest: sync_expired_merge
[468.596353] Subtest sync_expired_merge: SUCCESS (1.074s)
[468.693402] [099/132] (573s left) kms_cursor_crc (cursor-offscreen-128x128)
[470.358145] Starting subtest: cursor-offscreen-128x128
[470.365180] Starting dynamic subtest: pipe-A-HDMI-A-3
[472.883668] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.519s)
[472.921416] Starting dynamic subtest: pipe-D-HDMI-A-3
[475.320027] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.408s)
[475.320892] Subtest cursor-offscreen-128x128: SUCCESS (4.961s)
[475.741474] [100/132] (566s left) kms_big_fb (linear-16bpp-rotate-0)
[477.246770] Starting subtest: linear-16bpp-rotate-0
[479.379728] Subtest linear-16bpp-rotate-0: SUCCESS (2.128s)
[479.597350] [101/132] (562s left) kms_psr (fbc-psr2-primary-page-flip)
[481.082224] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[481.169716] [102/132] (560s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[482.675498] Starting subtest: x-tiled-64bpp-rotate-270
[482.749096] Subtest x-tiled-64bpp-rotate-270: SKIP (0.073s)
[482.945894] [103/132] (559s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[484.430196] Starting subtest: 2x-long-flip-vs-cursor-atomic
[484.433918] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.003s)
[484.550888] [104/132] (557s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[484.611523] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[484.612520] Starting dynamic subtest: smem
[484.724754] Dynamic subtest smem: SUCCESS (0.108s)
[484.736520] Starting dynamic subtest: lmem0
[485.678105] Dynamic subtest lmem0: SUCCESS (0.951s)
[485.679389] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (1.063s)
[485.962978] [105/132] (556s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[487.473001] Starting subtest: y-tiled-8bpp-rotate-90
[487.587060] Subtest y-tiled-8bpp-rotate-90: SKIP (0.118s)
[487.743123] [106/132] (554s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[489.229231] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[489.230168] Starting dynamic subtest: pipe-A-HDMI-A-3
[489.238819] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[489.250958] Starting dynamic subtest: pipe-B-HDMI-A-3
[489.259761] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[489.271401] Starting dynamic subtest: pipe-C-HDMI-A-3
[489.280550] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[489.292072] Starting dynamic subtest: pipe-D-HDMI-A-3
[489.301714] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[489.303487] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[489.505724] [107/132] (552s left) vgem_basic (setversion)
[489.556202] Starting subtest: setversion
[489.558082] Subtest setversion: SUCCESS (0.000s)
[489.653418] [108/132] (552s left) kms_content_protection (uevent-hdcp14)
[491.193764] Starting subtest: uevent-hdcp14
[491.197973] Subtest uevent-hdcp14: SKIP (0.002s)
[491.364855] [109/132] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[492.855207] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[492.857099] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[493.029191] [110/132] (549s left) kms_psr (psr-sprite-blt)
[494.515118] Subtest psr-sprite-blt: SKIP (0.000s)
[494.698423] [111/132] (548s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[494.751234] Starting subtest: y-tiled-to-vebox-y-tiled
[494.752105] Starting dynamic subtest: smem
[494.832594] Dynamic subtest smem: SUCCESS (0.081s)
[494.846090] Starting dynamic subtest: lmem0
[495.591826] Dynamic subtest lmem0: SUCCESS (0.753s)
[495.593130] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.837s)
[495.855590] [112/132] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[497.346829] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[497.349100] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[497.505636] [113/132] (545s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[499.021160] Starting subtest: modeset-transition-nonblocking-fencing
[499.022050] Starting dynamic subtest: 1x-outputs
[501.036966] Dynamic subtest 1x-outputs: SUCCESS (2.010s)
[501.039078] Subtest modeset-transition-nonblocking-fencing: SUCCESS (2.015s)
[501.227267] [114/132] (541s left) gem_eio (kms)
[502.857819] Starting subtest: kms
[527.696434] Subtest kms: SUCCESS (24.839s)
[527.924648] [115/132] (515s left) kms_psr (psr2-sprite-mmap-gtt)
[529.409740] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[529.495641] [116/132] (513s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[530.980255] Starting subtest: nonblocking-crc-frame-sequence
[530.981281] Starting dynamic subtest: pipe-A-HDMI-A-3
[531.755748] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.774s)
[531.770253] Starting dynamic subtest: pipe-B-HDMI-A-3
[532.320309] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.561s)
[532.334602] Starting dynamic subtest: pipe-C-HDMI-A-3
[532.936124] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.612s)
[532.949215] Starting dynamic subtest: pipe-D-HDMI-A-3
[533.508618] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.570s)
[533.509481] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.529s)
[533.722504] [117/132] (509s left) gem_userptr_blits (access-control)
[533.794583] Starting subtest: access-control
[533.796364] Subtest access-control: SKIP (0.000s)
[534.004789] [118/132] (509s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[535.507046] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[535.508094] Starting dynamic subtest: pipe-A-valid-mode
[538.046919] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.538s)
[538.047805] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (2.541s)
[538.240616] [119/132] (505s left) kms_psr (psr2-cursor-blt)
[539.728412] Subtest psr2-cursor-blt: SKIP (0.000s)
[539.800354] [120/132] (503s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[541.290569] Starting subtest: fbcpsr-rgb565-draw-pwrite
[541.292603] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[541.469004] [121/132] (502s left) vgem_basic (mmap)
[541.521198] Starting subtest: mmap
[541.532123] Subtest mmap: SUCCESS (0.011s)
[541.620518] [122/132] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[543.110710] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[543.112458] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[543.274435] [123/132] (500s left) syncobj_timeline (wait-all-delayed-signal)
[543.322366] Starting subtest: wait-all-delayed-signal
[543.428913] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[543.616437] [124/132] (500s left) gem_userptr_blits (invalid-null-pointer)
[543.669042] Starting subtest: invalid-null-pointer
[543.669975] Subtest invalid-null-pointer: SUCCESS (0.001s)
[543.860920] [125/132] (500s left) kms_prime (basic-crc-hybrid)
[545.367697] Subtest basic-crc-hybrid: SKIP (0.000s)
[545.589800] [126/132] (498s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[547.079818] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[547.081571] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.282861] [127/132] (497s left) gem_exec_reloc (basic-cpu-read-noreloc)
[547.333892] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[547.442634] [128/132] (496s left) prime_vgem (wait)
[547.512423] Starting subtest: wait
[547.513467] Starting dynamic subtest: rcs0
[547.553295] Dynamic subtest rcs0: SUCCESS (0.042s)
[547.567585] Starting dynamic subtest: bcs0
[547.597627] Dynamic subtest bcs0: SUCCESS (0.043s)
[547.614775] Starting dynamic subtest: vcs0
[547.639733] Dynamic subtest vcs0: SUCCESS (0.040s)
[547.660302] Starting dynamic subtest: vcs1
[547.680818] Dynamic subtest vcs1: SUCCESS (0.039s)
[547.701344] Starting dynamic subtest: vecs0
[547.722286] Dynamic subtest vecs0: SUCCESS (0.039s)
[547.723301] Subtest wait: SUCCESS (0.212s)
[547.918327] [129/132] (496s left) kms_cursor_crc (cursor-sliding-512x170)
[549.700186] Starting subtest: cursor-sliding-512x170
[549.703374] Subtest cursor-sliding-512x170: SKIP (0.001s)
[549.902133] [130/132] (494s left) kms_color (legacy-gamma-reset)
[551.388305] Starting subtest: legacy-gamma-reset
[551.389187] Starting dynamic subtest: pipe-A-HDMI-A-3
[551.673788] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.285s)
[551.686473] Starting dynamic subtest: pipe-B-HDMI-A-3
[551.726669] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.052s)
[551.740709] Starting dynamic subtest: pipe-C-HDMI-A-3
[551.766004] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.038s)
[551.780603] Starting dynamic subtest: pipe-D-HDMI-A-3
[551.806013] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.038s)
[551.807057] Subtest legacy-gamma-reset: SUCCESS (0.420s)
[551.959613] [131/132] (492s left) syncobj_wait (reset-multiple-signaled)
[552.005976] Starting subtest: reset-multiple-signaled
[552.006925] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[552.135450] [132/132] (492s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[553.635879] Starting subtest: psr-rgb101010-draw-pwrite
[553.637693] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[553.822995] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: gem_wait
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: gem_exec_whisper
results: parsing output: 20/ for test: dmabuf_sync_file
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: gem_ctx_exec
results: parsing output: 24/ for test: i915_pm_rps
results: parsing output: 25/ for test: gem_ctx_param
results: parsing output: 26/ for test: kms_rotation_crc
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_sequence
results: parsing output: 29/ for test: kms_plane_multiple
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_exec_store
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: kms_busy
results: parsing output: 34/ for test: sysfs_heartbeat_interval
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: gem_pread
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_pm_backlight
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_hdr
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_workarounds
results: parsing output: 54/ for test: gem_mmap_offset
results: parsing output: 55/ for test: gem_ctx_engines
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_ccs
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_draw_crc
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_module_load
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_pm_backlight
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: gem_exec_create
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_atomic_transition
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_pipe_crc_basic
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_prime
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: prime_vgem
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_color
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.