[58.875457] Initializing watchdogs
[58.875523]   /dev/watchdog0
[58.890591] [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]
[58.895211] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.897530] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.901629] [001/131] (960s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[58.986095] Starting subtest: etime-multi-wait-all-for-submit-submitted
[59.089676] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[59.163900] [002/131] (960s left) gem_exec_parallel (userptr)
[59.235464] Starting subtest: userptr
[59.237399] Starting dynamic subtest: rcs0
[60.776037] Dynamic subtest rcs0: SUCCESS (1.535s)
[60.785311] Starting dynamic subtest: bcs0
[62.293352] Dynamic subtest bcs0: SUCCESS (1.510s)
[62.305083] Starting dynamic subtest: vcs0
[63.930274] Dynamic subtest vcs0: SUCCESS (1.630s)
[63.938898] Starting dynamic subtest: vcs1
[65.880328] Dynamic subtest vcs1: SUCCESS (1.944s)
[65.891038] Starting dynamic subtest: vecs0
[67.951312] Dynamic subtest vecs0: SUCCESS (2.066s)
[67.959568] Starting dynamic subtest: ccs0
[69.525580] Dynamic subtest ccs0: SUCCESS (1.572s)
[69.528078] Subtest userptr: SUCCESS (10.263s)
[69.725329] [003/131] (949s left) gem_workarounds (reset-fd)
[69.796502] Starting subtest: reset-fd
[69.994290] Subtest reset-fd: SUCCESS (0.198s)
[70.110475] [004/131] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[70.210160] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[70.922981] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.714s)
[71.095693] [005/131] (948s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[71.161255] Starting subtest: multi-wait-for-submit-available-submitted
[71.163588] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[71.279309] [006/131] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[71.378764] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[71.382947] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.479936] [007/131] (948s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[71.570341] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[71.572659] Starting dynamic subtest: pipe-A-eDP-1
[72.004549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[72.014604] Starting dynamic subtest: pipe-B-eDP-1
[72.031631] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[72.041071] Starting dynamic subtest: pipe-C-eDP-1
[72.057868] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[72.065856] Starting dynamic subtest: pipe-D-eDP-1
[72.082086] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[72.083962] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.449s)
[74.306072] [008/131] (945s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[74.414405] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[81.200853] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.787s)
[81.322795] [009/131] (938s left) kms_plane_multiple (tiling-yf)
[81.417807] Starting subtest: tiling-yf
[81.422289] Subtest tiling-yf: SKIP (0.000s)
[81.489627] [010/131] (938s left) kms_invalid_mode (zero-vdisplay)
[81.575379] Starting subtest: zero-vdisplay
[81.577603] Starting dynamic subtest: pipe-A-eDP-1
[81.871763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[81.881685] Starting dynamic subtest: pipe-B-eDP-1
[81.883653] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[81.891167] Starting dynamic subtest: pipe-C-eDP-1
[81.893502] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[81.901316] Starting dynamic subtest: pipe-D-eDP-1
[81.903806] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[81.906312] Subtest zero-vdisplay: SUCCESS (0.300s)
[82.670225] [011/131] (937s left) gem_exec_flush (basic-uc-rw-default)
[82.732851] Starting subtest: basic-uc-rw-default
[88.192681] Subtest basic-uc-rw-default: SUCCESS (5.459s)
[88.375207] [012/131] (931s left) kms_big_fb (x-tiled-addfb)
[88.497439] Starting subtest: x-tiled-addfb
[88.499876] Subtest x-tiled-addfb: SUCCESS (0.000s)
[88.590272] [013/131] (931s left) i915_pm_rpm (gem-evict-pwrite)
[90.122031] Starting subtest: gem-evict-pwrite
[90.127378] Subtest gem-evict-pwrite: SKIP (0.000s)
[90.828729] [014/131] (929s left) gem_ctx_param (invalid-size-set)
[90.880683] Starting subtest: invalid-size-set
[90.883024] Subtest invalid-size-set: SUCCESS (0.001s)
[90.989730] [015/131] (928s left) i915_hangman (gt-engine-error)
[91.050315] Starting subtest: gt-engine-error
[91.052445] Starting dynamic subtest: rcs0
[92.854315] Dynamic subtest rcs0: SUCCESS (1.802s)
[92.864482] Starting dynamic subtest: bcs0
[94.837337] Dynamic subtest bcs0: SUCCESS (1.981s)
[94.849761] Starting dynamic subtest: vcs0
[96.885405] Dynamic subtest vcs0: SUCCESS (2.046s)
[96.896605] Starting dynamic subtest: vcs1
[98.868324] Dynamic subtest vcs1: SUCCESS (1.982s)
[98.882049] Starting dynamic subtest: vecs0
[100.853457] Dynamic subtest vecs0: SUCCESS (1.983s)
[100.863842] Starting dynamic subtest: ccs0
[102.902107] Dynamic subtest ccs0: SUCCESS (2.047s)
[102.904737] Subtest gt-engine-error: SUCCESS (11.849s)
[103.016269] [016/131] (916s left) kms_flip (2x-plain-flip-fb-recreate)
[103.110724] Starting subtest: 2x-plain-flip-fb-recreate
[103.119990] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[103.195936] [017/131] (916s left) api_intel_bb (delta-check)
[103.256015] Starting subtest: delta-check
[103.260494] Subtest delta-check: SUCCESS (0.005s)
[103.409964] [018/131] (916s left) gem_ctx_param (non-root-set)
[103.479582] Starting subtest: non-root-set
[103.500518] Subtest non-root-set: SUCCESS (0.021s)
[103.599955] [019/131] (916s left) kms_addfb_basic (invalid-set-prop-any)
[103.665583] Starting subtest: invalid-set-prop-any
[103.667805] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[103.795277] [020/131] (916s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[103.840233] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[103.897979] [021/131] (916s left) kms_psr (pr-primary-page-flip)
[103.988042] Starting subtest: pr-primary-page-flip
[103.991850] Subtest pr-primary-page-flip: SKIP (0.000s)
[104.057611] [022/131] (916s left) kms_properties (crtc-properties-legacy)
[104.140544] Starting subtest: crtc-properties-legacy
[104.142311] Starting dynamic subtest: pipe-A-eDP-1
[104.581997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[104.592916] Starting dynamic subtest: pipe-B-eDP-1
[105.775459] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[105.786719] Starting dynamic subtest: pipe-C-eDP-1
[106.895970] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[106.905633] Starting dynamic subtest: pipe-D-eDP-1
[108.038109] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[108.040454] Subtest crtc-properties-legacy: SUCCESS (3.896s)
[108.856669] [023/131] (911s left) kms_cursor_crc (cursor-offscreen-64x64)
[109.065993] Starting subtest: cursor-offscreen-64x64
[109.070881] Starting dynamic subtest: pipe-A-eDP-1
[111.037594] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.965s)
[111.062911] Starting dynamic subtest: pipe-D-eDP-1
[113.672593] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s)
[113.674984] Subtest cursor-offscreen-64x64: SUCCESS (4.606s)
[114.541391] [024/131] (905s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[114.657358] Starting subtest: cursorA-vs-flipA-atomic
[125.771652] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.113s)
[126.654108] [025/131] (893s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[126.764515] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[126.768875] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[126.857802] [026/131] (893s left) syncobj_basic (bad-flags-handle-to-fd)
[126.917813] Starting subtest: bad-flags-handle-to-fd
[126.920153] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[127.014160] [027/131] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[127.114890] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[127.119383] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[127.218218] [028/131] (893s left) sysfs_timeslice_duration (timeout)
[127.287693] Starting subtest: timeout
[127.290052] Starting dynamic subtest: vecs0
[136.915357] Dynamic subtest vecs0: SUCCESS (9.623s)
[136.926740] Starting dynamic subtest: ccs0
[138.192094] Dynamic subtest ccs0: SUCCESS (1.277s)
[138.202582] Starting dynamic subtest: vcs0
[147.925024] Dynamic subtest vcs0: SUCCESS (9.729s)
[147.934958] Starting dynamic subtest: bcs0
[148.585704] Dynamic subtest bcs0: SUCCESS (0.663s)
[148.594062] Starting dynamic subtest: rcs0
[149.837070] Dynamic subtest rcs0: SUCCESS (1.250s)
[149.847860] Starting dynamic subtest: vcs1
[159.890199] Dynamic subtest vcs1: SUCCESS (10.050s)
[159.892652] Subtest timeout: SUCCESS (32.599s)
[159.967524] [029/131] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[160.074060] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[182.974112] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.903s)
[183.120031] [030/131] (837s left) kms_chamelium_frames (dp-frame-dump)
[183.500704] Subtest dp-frame-dump: SKIP (0.000s)
[184.276170] [031/131] (836s left) gem_reg_read (bad-register)
[184.338375] Starting subtest: bad-register
[184.340336] Subtest bad-register: SUCCESS (0.000s)
[184.441035] [032/131] (836s left) kms_vrr (flip-basic-fastset)
[184.539885] Starting subtest: flip-basic-fastset
[184.546555] Subtest flip-basic-fastset: SKIP (0.000s)
[184.608923] [033/131] (836s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[184.707244] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[184.709571] Starting dynamic subtest: pipe-A-eDP-1
[184.733283] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[184.743634] Starting dynamic subtest: pipe-B-eDP-1
[184.764292] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[184.772060] Starting dynamic subtest: pipe-C-eDP-1
[184.793620] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[184.801778] Starting dynamic subtest: pipe-D-eDP-1
[184.823525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[184.827861] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[186.880832] [034/131] (833s left) i915_suspend (fence-restore-tiled2untiled)
[186.946786] Starting subtest: fence-restore-tiled2untiled
[186.951544] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[187.051593] [035/131] (833s left) gem_mmap (basic)
[187.119927] Subtest basic: SKIP (0.000s)
[187.186425] [036/131] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[187.296447] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[187.300896] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[187.395369] [037/131] (833s left) gem_ctx_engines (execute-allforone)
[187.475988] Starting subtest: execute-allforone
[187.491545] Subtest execute-allforone: SUCCESS (0.015s)
[188.956712] [038/131] (831s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[189.069669] Starting subtest: pr-overlay-plane-move-continuous-sf
[189.073745] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[189.135517] [039/131] (831s left) kms_plane (pixel-format-yf-tiled-modifier)
[189.233633] Starting subtest: pixel-format-yf-tiled-modifier
[189.238053] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[189.323260] [040/131] (831s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[189.382616] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[189.445599] [041/131] (831s left) kms_getfb (getfb-addfb-different-handles)
[189.536478] Starting subtest: getfb-addfb-different-handles
[189.538752] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[189.634437] [042/131] (831s left) gem_bad_reloc (negative-reloc)
[189.699481] Subtest negative-reloc: SKIP (0.000s)
[189.764279] [043/131] (831s left) kms_async_flips (test-cursor-atomic)
[189.860280] Starting subtest: test-cursor-atomic
[190.233522] Starting dynamic subtest: pipe-A-eDP-1
[190.984197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.751s)
[191.366594] Starting dynamic subtest: pipe-B-eDP-1
[192.113231] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[192.489998] Starting dynamic subtest: pipe-C-eDP-1
[193.235444] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.752s)
[193.601753] Starting dynamic subtest: pipe-D-eDP-1
[194.363618] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[194.365936] Subtest test-cursor-atomic: SUCCESS (4.506s)
[195.549380] [044/131] (825s left) gen7_exec_parse (cmd-crossing-page)
[195.615181] Subtest cmd-crossing-page: SKIP (0.000s)
[195.683155] [045/131] (825s left) i915_query (query-topology-unsupported)
[195.735032] Starting subtest: query-topology-unsupported
[195.739318] Subtest query-topology-unsupported: SKIP (0.000s)
[195.843574] [046/131] (825s left) gem_spin_batch (spin-each)
[195.902053] Starting subtest: spin-each
[199.262807] Subtest spin-each: SUCCESS (3.360s)
[199.905691] [047/131] (821s left) gem_ctx_isolation (dirty-switch)
[199.965747] Starting subtest: dirty-switch
[199.968120] Starting dynamic subtest: rcs0
[200.180221] Dynamic subtest rcs0: SUCCESS (0.213s)
[200.190463] Starting dynamic subtest: bcs0
[200.453203] Dynamic subtest bcs0: SUCCESS (0.273s)
[200.464287] Starting dynamic subtest: vcs0
[200.708432] Dynamic subtest vcs0: SUCCESS (0.255s)
[200.717975] Starting dynamic subtest: vcs1
[202.138942] Dynamic subtest vcs1: SUCCESS (1.429s)
[202.148980] Starting dynamic subtest: vecs0
[204.123145] Dynamic subtest vecs0: SUCCESS (1.983s)
[204.132137] Starting dynamic subtest: ccs0
[206.135230] Dynamic subtest ccs0: SUCCESS (2.011s)
[206.137684] Subtest dirty-switch: SUCCESS (6.169s)
[206.382323] [048/131] (814s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[206.486187] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[206.490807] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[206.582948] [049/131] (814s left) sw_sync (sync_busy_fork)
[206.623133] Starting subtest: sync_busy_fork
[207.633588] Subtest sync_busy_fork: SUCCESS (1.011s)
[207.709324] [050/131] (813s left) prime_busy (after-wait)
[207.766546] Starting subtest: after-wait
[207.768947] Starting dynamic subtest: rcs0
[207.793706] Dynamic subtest rcs0: SUCCESS (0.027s)
[207.803987] Starting dynamic subtest: bcs0
[207.833862] Dynamic subtest bcs0: SUCCESS (0.039s)
[207.841950] Starting dynamic subtest: vcs0
[207.873267] Dynamic subtest vcs0: SUCCESS (0.039s)
[207.881190] Starting dynamic subtest: vcs1
[207.911985] Dynamic subtest vcs1: SUCCESS (0.038s)
[207.920021] Starting dynamic subtest: vecs0
[207.950972] Dynamic subtest vecs0: SUCCESS (0.038s)
[207.959063] Starting dynamic subtest: ccs0
[207.989211] Dynamic subtest ccs0: SUCCESS (0.038s)
[208.098412] Subtest after-wait: SUCCESS (0.333s)
[208.181896] [051/131] (813s left) drm_read (empty-nonblock)
[208.321061] Starting subtest: empty-nonblock
[208.323439] Subtest empty-nonblock: SUCCESS (0.000s)
[208.441580] [052/131] (813s left) kms_psr (psr2-sprite-blt)
[208.531053] Starting subtest: psr2-sprite-blt
[208.533310] Starting dynamic subtest: eDP-1
[210.237686] Dynamic subtest eDP-1: SUCCESS (1.704s)
[210.239558] Subtest psr2-sprite-blt: SUCCESS (1.705s)
[211.105680] [053/131] (810s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[211.197348] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[211.199688] Starting dynamic subtest: pipe-A-eDP-1
[211.222616] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.235048] Starting dynamic subtest: pipe-B-eDP-1
[211.256818] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.267667] Starting dynamic subtest: pipe-C-eDP-1
[211.289208] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.297434] Starting dynamic subtest: pipe-D-eDP-1
[211.319611] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.324063] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[213.474788] [054/131] (808s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[213.530305] Subtest tiled-to-tiled: SKIP (0.000s)
[213.584362] [055/131] (807s left) kms_flip (blocking-wf_vblank)
[213.671093] Starting subtest: blocking-wf_vblank
[213.672936] Starting dynamic subtest: A-eDP1
[222.613588] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[222.621820] Starting dynamic subtest: B-eDP1
[231.548562] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[231.560920] Starting dynamic subtest: C-eDP1
[240.477751] Dynamic subtest C-eDP1: SUCCESS (8.927s)
[240.490982] Starting dynamic subtest: D-eDP1
[249.412111] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[249.414454] Subtest blocking-wf_vblank: SUCCESS (35.742s)
[250.614151] [056/131] (770s left) kms_flip (2x-nonexisting-fb)
[250.701680] Starting subtest: 2x-nonexisting-fb
[250.711239] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[250.787573] [057/131] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[250.886186] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[250.890130] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[250.984493] [058/131] (770s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[253.009049] Starting subtest: dpms-mode-unset-non-lpsp
[254.166815] Subtest dpms-mode-unset-non-lpsp: SKIP (1.155s)
[254.544958] [059/131] (767s left) gem_exec_balancer (parallel-contexts)
[254.819072] Starting subtest: parallel-contexts
[258.084527] Subtest parallel-contexts: SUCCESS (3.264s)
[259.032976] [060/131] (762s left) kms_psr (fbc-psr-basic)
[259.133783] Starting subtest: fbc-psr-basic
[259.136053] Starting dynamic subtest: eDP-1
[259.140249] Dynamic subtest eDP-1: SKIP (0.000s)
[259.144504] Subtest fbc-psr-basic: SKIP (0.001s)
[259.206817] [061/131] (762s left) gem_tiled_blits (basic)
[259.262490] Subtest basic: SKIP (0.000s)
[259.326539] [062/131] (762s left) gem_mmap (basic-small-bo)
[259.375600] Subtest basic-small-bo: SKIP (0.000s)
[259.428916] [063/131] (762s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[259.525363] Starting subtest: psr-1p-pri-indfb-multidraw
[282.285411] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.762s)
[282.396412] [064/131] (739s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[282.504219] Starting subtest: plane-lut1d-ctm3x4
[282.628381] Starting dynamic subtest: pipe-A-plane-0
[282.795059] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[282.803619] Starting dynamic subtest: pipe-A-plane-1
[282.950771] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[282.959462] Starting dynamic subtest: pipe-A-plane-2
[283.095042] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s)
[284.236493] Starting dynamic subtest: pipe-B-plane-0
[284.396149] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[284.405443] Starting dynamic subtest: pipe-B-plane-1
[284.540739] Dynamic subtest pipe-B-plane-1: SUCCESS (0.143s)
[284.549597] Starting dynamic subtest: pipe-B-plane-2
[284.685821] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[285.872236] Starting dynamic subtest: pipe-C-plane-0
[286.009631] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[286.018842] Starting dynamic subtest: pipe-C-plane-1
[286.154066] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[286.162971] Starting dynamic subtest: pipe-C-plane-2
[286.298496] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[287.518869] Starting dynamic subtest: pipe-D-plane-0
[287.655619] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[287.664581] Starting dynamic subtest: pipe-D-plane-1
[287.811167] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[287.820434] Starting dynamic subtest: pipe-D-plane-2
[287.955813] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[288.240957] Subtest plane-lut1d-ctm3x4: SUCCESS (5.737s)
[289.082711] [065/131] (732s left) syncobj_timeline (multi-wait-all-available-signaled)
[289.145907] Starting subtest: multi-wait-all-available-signaled
[289.148246] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[289.250119] [066/131] (732s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[289.348905] Starting subtest: multiplane-rotation-cropping-bottom
[306.840872] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.493s)
[306.950339] [067/131] (715s left) gem_mmap_offset (bad-extensions)
[307.012288] Starting subtest: bad-extensions
[307.013881] Subtest bad-extensions: SUCCESS (0.000s)
[307.119763] [068/131] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[307.213122] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[307.216530] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[307.316157] [069/131] (714s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[307.408129] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[307.409950] Starting dynamic subtest: pipe-A
[307.471229] Dynamic subtest pipe-A: SUCCESS (0.064s)
[307.479759] Starting dynamic subtest: pipe-B
[308.610948] Dynamic subtest pipe-B: SUCCESS (1.138s)
[308.619881] Starting dynamic subtest: pipe-C
[309.723637] Dynamic subtest pipe-C: SUCCESS (1.112s)
[309.732447] Starting dynamic subtest: pipe-D
[310.854766] Dynamic subtest pipe-D: SUCCESS (1.130s)
[310.857244] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.448s)
[312.028300] [070/131] (710s left) gem_exec_schedule (submit-golden-slice)
[312.110247] Starting subtest: submit-golden-slice
[312.112157] Starting dynamic subtest: rcs0
[312.143646] Dynamic subtest rcs0: SUCCESS (0.041s)
[312.157508] Starting dynamic subtest: bcs0
[312.187505] Dynamic subtest bcs0: SUCCESS (0.042s)
[312.196370] Starting dynamic subtest: vcs0
[312.222763] Dynamic subtest vcs0: SUCCESS (0.035s)
[312.234369] Starting dynamic subtest: vcs1
[312.260409] Dynamic subtest vcs1: SUCCESS (0.037s)
[312.269609] Starting dynamic subtest: vecs0
[312.291847] Dynamic subtest vecs0: SUCCESS (0.030s)
[312.303308] Starting dynamic subtest: ccs0
[312.332844] Dynamic subtest ccs0: SUCCESS (0.041s)
[312.335149] Subtest submit-golden-slice: SUCCESS (0.231s)
[314.028524] [071/131] (708s left) gem_exec_fence (syncobj-invalid-flags)
[314.523958] Starting subtest: syncobj-invalid-flags
[314.526421] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[316.036544] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[316.043817] [072/131] (706s left) i915_drm_fdinfo (memory-info-purgeable)
[316.098075] Starting subtest: memory-info-purgeable
[316.100303] Starting dynamic subtest: smem0
[318.947583] Dynamic subtest smem0: SUCCESS (2.852s)
[318.949927] Subtest memory-info-purgeable: SUCCESS (2.853s)
[319.022889] [073/131] (703s left) gem_ctx_persistence (legacy-engines-hostile)
[319.099134] Starting subtest: legacy-engines-hostile
[319.101095] Starting dynamic subtest: render
[319.245956] Dynamic subtest render: SUCCESS (0.145s)
[319.260212] Starting dynamic subtest: bsd1
[319.338443] Dynamic subtest bsd1: SUCCESS (0.090s)
[319.351989] Starting dynamic subtest: bsd2
[319.439805] Dynamic subtest bsd2: SUCCESS (0.098s)
[319.454072] Starting dynamic subtest: blt
[319.551623] Dynamic subtest blt: SUCCESS (0.109s)
[319.564664] Starting dynamic subtest: vebox
[319.646720] Dynamic subtest vebox: SUCCESS (0.092s)
[319.649531] Subtest legacy-engines-hostile: SUCCESS (0.549s)
[319.730216] [074/131] (702s left) kms_vrr (seamless-rr-switch-vrr)
[319.838096] Starting subtest: seamless-rr-switch-vrr
[319.843771] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[319.913649] [075/131] (702s left) kms_psr (fbc-pr-primary-mmap-cpu)
[320.005531] Starting subtest: fbc-pr-primary-mmap-cpu
[320.009270] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[320.077124] [076/131] (702s left) kms_cursor_crc (cursor-random-32x10)
[320.241421] Starting subtest: cursor-random-32x10
[320.288163] Subtest cursor-random-32x10: SKIP (0.042s)
[320.554785] [077/131] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[320.641140] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[325.101337] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.463s)
[326.242808] [078/131] (696s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[326.344431] Starting subtest: y-tiled-16bpp-rotate-270
[326.348913] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[326.437615] [079/131] (696s left) kms_flip (modeset-vs-vblank-race)
[326.526082] Starting subtest: modeset-vs-vblank-race
[326.528377] Starting dynamic subtest: A-eDP1
[331.236648] Dynamic subtest A-eDP1: SUCCESS (4.709s)
[331.246930] Starting dynamic subtest: B-eDP1
[335.981565] Dynamic subtest B-eDP1: SUCCESS (4.742s)
[335.993794] Starting dynamic subtest: C-eDP1
[340.593225] Dynamic subtest C-eDP1: SUCCESS (4.609s)
[340.602156] Starting dynamic subtest: D-eDP1
[345.224660] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[345.229515] Subtest modeset-vs-vblank-race: SUCCESS (18.702s)
[346.406641] [080/131] (676s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[346.468505] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[346.472933] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[346.652818] [081/131] (676s left) gem_eio (wait-immediate)
[346.878288] Starting subtest: wait-immediate
[347.251554] Subtest wait-immediate: SUCCESS (0.376s)
[347.391972] [082/131] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[347.481698] Starting subtest: fbcpsr-1p-rte
[354.531477] Subtest fbcpsr-1p-rte: SUCCESS (7.054s)
[354.686919] [083/131] (668s left) gem_exec_schedule (noreorder-priority)
[354.880704] Starting subtest: noreorder-priority
[354.882641] Starting dynamic subtest: rcs0
[356.006639] Dynamic subtest rcs0: SUCCESS (1.128s)
[356.015744] Starting dynamic subtest: vcs0
[357.905979] Dynamic subtest vcs0: SUCCESS (1.896s)
[357.923896] Starting dynamic subtest: vcs1
[359.893533] Dynamic subtest vcs1: SUCCESS (1.984s)
[359.902973] Starting dynamic subtest: vecs0
[361.852424] Dynamic subtest vecs0: SUCCESS (1.957s)
[361.864286] Starting dynamic subtest: ccs0
[362.993075] Dynamic subtest ccs0: SUCCESS (1.139s)
[362.995913] Subtest noreorder-priority: SUCCESS (8.116s)
[363.181626] [084/131] (659s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[363.293548] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[367.738780] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.446s)
[368.943566] [085/131] (653s left) api_intel_bb (blit-reloc-purge-cache)
[369.006283] Starting subtest: blit-reloc-purge-cache
[369.010573] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[369.129686] [086/131] (653s left) kms_prop_blob (blob-prop-lifetime)
[369.187505] Starting subtest: blob-prop-lifetime
[369.189424] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[369.292336] [087/131] (653s left) kms_cursor_crc (cursor-sliding-512x170)
[369.592494] Starting subtest: cursor-sliding-512x170
[369.597257] Subtest cursor-sliding-512x170: SKIP (0.001s)
[369.742647] [088/131] (653s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[369.791118] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[369.898438] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[369.978964] [089/131] (653s left) gem_flink_basic (bad-open)
[370.035059] Starting subtest: bad-open
[370.037473] Subtest bad-open: SUCCESS (0.000s)
[370.156105] [090/131] (652s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[370.248577] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[370.252757] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[370.342080] [091/131] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[370.439851] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[370.444355] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[370.534407] [092/131] (652s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[370.630456] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[370.634679] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[370.726461] [093/131] (652s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[370.815194] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[370.819776] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[371.961550] [094/131] (651s left) kms_psr (fbc-psr2-basic)
[372.057785] Starting subtest: fbc-psr2-basic
[372.059916] Starting dynamic subtest: eDP-1
[372.063856] Dynamic subtest eDP-1: SKIP (0.000s)
[372.067776] Subtest fbc-psr2-basic: SKIP (0.001s)
[372.142663] [095/131] (651s left) gem_exec_balancer (indices)
[372.205824] Starting subtest: indices
[374.900815] Subtest indices: SUCCESS (2.692s)
[375.201043] [096/131] (648s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[375.258133] Starting subtest: yf-tiled-ccs-to-yf-tiled
[375.262641] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[375.460629] [097/131] (647s left) kms_selftest (drm_damage_helper)
[375.503491] Starting subtest: drm_damage_helper
[375.519907] Starting dynamic subtest: drm_test_damage_iter_no_damage
[375.625887] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.104s)
[375.635900] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[375.710101] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.084s)
[375.719649] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[375.812852] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.101s)
[375.822508] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[375.906176] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.092s)
[375.916434] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[375.999940] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.094s)
[376.010136] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[376.086151] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.085s)
[376.096142] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[376.194976] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.109s)
[376.205238] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[376.298944] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.102s)
[376.309246] Starting dynamic subtest: drm_test_damage_iter_single_damage
[376.400149] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.100s)
[376.410760] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[376.495871] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.095s)
[376.506187] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[376.586971] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.091s)
[376.597041] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[376.667515] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.080s)
[376.677196] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[376.749299] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.081s)
[376.758989] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[376.834467] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.084s)
[376.844343] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[376.930640] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.095s)
[376.939292] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[377.012387] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.081s)
[377.022452] Starting dynamic subtest: drm_test_damage_iter_damage
[377.090556] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.078s)
[377.100242] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[377.175286] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.084s)
[377.185154] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[377.269176] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.094s)
[377.277227] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[377.351183] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.081s)
[377.361347] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[377.447674] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.095s)
[377.449636] Subtest drm_damage_helper: SUCCESS (1.945s)
[377.591603] [098/131] (645s left) kms_pm_rpm (package-g7)
[379.121065] Starting subtest: package-g7
[379.126220] Subtest package-g7: SKIP (0.000s)
[379.904433] [099/131] (643s left) kms_getfb (getfb2-into-addfb2)
[379.996962] Starting subtest: getfb2-into-addfb2
[379.999240] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[380.084561] [100/131] (643s left) gem_partial_pwrite_pread (write-uncached)
[380.134807] Subtest write-uncached: SKIP (0.000s)
[380.197851] [101/131] (643s left) gem_wait (wait)
[380.257477] Starting subtest: wait
[380.259671] Starting dynamic subtest: all-engines
[381.910180] Dynamic subtest all-engines: SUCCESS (1.650s)
[381.921767] Starting dynamic subtest: rcs0
[382.956064] Dynamic subtest rcs0: SUCCESS (1.045s)
[382.965614] Starting dynamic subtest: bcs0
[384.010163] Dynamic subtest bcs0: SUCCESS (1.052s)
[384.024160] Starting dynamic subtest: vcs0
[385.060538] Dynamic subtest vcs0: SUCCESS (1.047s)
[385.078369] Starting dynamic subtest: vcs1
[386.106385] Dynamic subtest vcs1: SUCCESS (1.043s)
[386.118085] Starting dynamic subtest: vecs0
[387.151059] Dynamic subtest vecs0: SUCCESS (1.042s)
[387.162053] Starting dynamic subtest: ccs0
[388.199324] Dynamic subtest ccs0: SUCCESS (1.046s)
[388.201846] Subtest wait: SUCCESS (7.942s)
[388.397284] [102/131] (635s left) gem_exec_flush (basic-wb-pro-default)
[388.478570] Starting subtest: basic-wb-pro-default
[393.975787] Subtest basic-wb-pro-default: SUCCESS (5.497s)
[394.166890] [103/131] (629s left) gem_close (basic)
[394.232025] Starting subtest: basic
[394.234894] Subtest basic: SUCCESS (0.000s)
[394.333606] [104/131] (629s left) gem_pipe_control_store_loop (fresh-buffer)
[394.391869] Starting subtest: fresh-buffer
[396.544269] Subtest fresh-buffer: SUCCESS (2.154s)
[396.652291] [105/131] (627s left) dmabuf_sync_file (import-basic)
[396.702892] Starting subtest: import-basic
[396.705143] Subtest import-basic: SUCCESS (0.001s)
[396.760112] [106/131] (626s left) kms_display_modes (extended-mode-basic)
[396.853724] Starting subtest: extended-mode-basic
[396.858224] Subtest extended-mode-basic: SKIP (0.000s)
[396.902730] [107/131] (626s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[397.012208] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[397.692516] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[397.841358] [108/131] (625s left) kms_plane (plane-panning-bottom-right-suspend)
[397.932928] Starting subtest: plane-panning-bottom-right-suspend
[397.935191] Starting dynamic subtest: pipe-A
[415.800032] Dynamic subtest pipe-A: SUCCESS (3.056s)
[415.810469] Starting dynamic subtest: pipe-B
[434.772512] Dynamic subtest pipe-B: SUCCESS (3.452s)
[434.774775] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.511s)
[435.619507] [109/131] (588s left) gem_mmap (bad-object)
[435.683220] Subtest bad-object: SKIP (0.000s)
[435.751980] [110/131] (588s left) gem_exec_whisper (basic-forked)
[435.816471] Starting subtest: basic-forked
[443.216583] Subtest basic-forked: SUCCESS (7.278s)
[443.417299] [111/131] (580s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[444.610065] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[444.933072] [112/131] (579s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[444.996069] Starting subtest: single-wait-all-for-submit-available-submitted
[444.997963] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[445.089139] [113/131] (578s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[445.177037] Starting subtest: read-crc-frame-sequence
[445.179270] Starting dynamic subtest: pipe-A-eDP-1
[445.897755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[445.909066] Starting dynamic subtest: pipe-B-eDP-1
[447.271884] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[447.282706] Starting dynamic subtest: pipe-C-eDP-1
[448.656973] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[448.667917] Starting dynamic subtest: pipe-D-eDP-1
[449.997217] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[449.999408] Subtest read-crc-frame-sequence: SUCCESS (4.793s)
[450.827289] [114/131] (573s left) kms_feature_discovery (display)
[450.919516] Starting subtest: display
[450.921678] Subtest display: SUCCESS (0.000s)
[450.995818] [115/131] (573s left) kms_big_fb (linear-64bpp-rotate-180)
[451.101012] Starting subtest: linear-64bpp-rotate-180
[452.731082] Subtest linear-64bpp-rotate-180: SUCCESS (1.624s)
[452.890858] [116/131] (571s left) kms_async_flips (alternate-sync-async-flip)
[452.982616] Starting subtest: alternate-sync-async-flip
[453.357315] Starting dynamic subtest: pipe-A-eDP-1
[456.100837] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.737s)
[456.485757] Starting dynamic subtest: pipe-B-eDP-1
[459.265018] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.782s)
[459.646168] Starting dynamic subtest: pipe-C-eDP-1
[462.402571] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[462.770146] Starting dynamic subtest: pipe-D-eDP-1
[465.530911] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[465.533105] Subtest alternate-sync-async-flip: SUCCESS (12.529s)
[466.692977] [117/131] (557s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[466.801430] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[466.803575] Starting dynamic subtest: pipe-A-eDP-1
[466.827510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[466.838458] Starting dynamic subtest: pipe-B-eDP-1
[466.861485] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[466.870988] Starting dynamic subtest: pipe-C-eDP-1
[466.894071] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[466.903406] Starting dynamic subtest: pipe-D-eDP-1
[466.927627] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[466.931960] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[468.958355] [118/131] (555s left) kms_busy (extended-pageflip-hang-newfb)
[469.056746] Starting subtest: extended-pageflip-hang-newfb
[469.059028] Starting dynamic subtest: pipe-A
[495.945722] Dynamic subtest pipe-A: SUCCESS (26.888s)
[495.956037] Starting dynamic subtest: pipe-D
[510.939129] Dynamic subtest pipe-D: SUCCESS (14.986s)
[510.941397] Subtest extended-pageflip-hang-newfb: SUCCESS (41.879s)
[511.803473] [119/131] (512s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[511.901749] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[511.912545] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[511.992225] [120/131] (512s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[512.041096] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[512.089805] [121/131] (512s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[512.183374] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[519.680856] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.498s)
[519.821331] [122/131] (504s left) kms_content_protection (uevent)
[519.963393] Starting subtest: uevent
[519.967984] Subtest uevent: SKIP (0.000s)
[520.096743] [123/131] (504s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[520.196553] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[520.198735] Starting dynamic subtest: pipe-A-default-mode
[521.398846] Dynamic subtest pipe-A-default-mode: SKIP (1.198s)
[521.402797] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.199s)
[521.572024] [124/131] (502s left) gem_mmap_wc (bad-offset)
[521.636956] Subtest bad-offset: SKIP (0.000s)
[521.695172] [125/131] (502s left) gem_exec_params (invalid-ring)
[521.749243] Starting subtest: invalid-ring
[521.751574] Subtest invalid-ring: SUCCESS (0.000s)
[521.844921] [126/131] (502s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[521.954826] Starting subtest: flip-vs-dpms-on-nop-interruptible
[521.957119] Starting dynamic subtest: A-eDP1
[523.779682] Dynamic subtest A-eDP1: SUCCESS (1.822s)
[523.795363] Starting dynamic subtest: B-eDP1
[525.609289] Dynamic subtest B-eDP1: SUCCESS (1.826s)
[525.620451] Starting dynamic subtest: C-eDP1
[527.433267] Dynamic subtest C-eDP1: SUCCESS (1.821s)
[527.444795] Starting dynamic subtest: D-eDP1
[529.268241] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[529.273285] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.315s)
[530.467359] [127/131] (494s left) perf_pmu (render-node-busy)
[530.537433] Starting subtest: render-node-busy
[530.539883] Starting dynamic subtest: rcs0
[531.115289] Dynamic subtest rcs0: SUCCESS (0.577s)
[531.131703] Starting dynamic subtest: bcs0
[531.676796] Dynamic subtest bcs0: SUCCESS (0.558s)
[531.689997] Starting dynamic subtest: vcs0
[533.174173] Dynamic subtest vcs0: SUCCESS (1.494s)
[533.187505] Starting dynamic subtest: vcs1
[535.157338] Dynamic subtest vcs1: SUCCESS (1.981s)
[535.167924] Starting dynamic subtest: vecs0
[537.142135] Dynamic subtest vecs0: SUCCESS (1.983s)
[537.155120] Starting dynamic subtest: ccs0
[537.712829] Dynamic subtest ccs0: SUCCESS (0.569s)
[537.715625] Subtest render-node-busy: SUCCESS (7.178s)
[537.795372] [128/131] (486s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[537.908257] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[537.912633] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[538.013764] [129/131] (486s left) kms_lease (setcrtc-implicit-plane)
[538.108745] Starting subtest: setcrtc-implicit-plane
[538.111071] Starting dynamic subtest: pipe-A-eDP-1
[538.588127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[538.599578] Starting dynamic subtest: pipe-B-eDP-1
[539.683628] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.096s)
[539.694719] Starting dynamic subtest: pipe-C-eDP-1
[540.809157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[540.819736] Starting dynamic subtest: pipe-D-eDP-1
[541.934995] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[541.937214] Subtest setcrtc-implicit-plane: SUCCESS (3.828s)
[542.781138] [130/131] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[542.881604] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[549.575839] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.696s)
[549.701877] [131/131] (475s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[549.797866] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[549.802166] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[549.891262] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_exec_parallel
results: parsing output: 2/ for test: gem_workarounds
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: i915_pm_rpm
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: i915_hangman
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_pipe_b_c_ivb
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_properties
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_basic
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: sysfs_timeslice_duration
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_chamelium_frames
results: parsing output: 30/ for test: gem_reg_read
results: parsing output: 31/ for test: kms_vrr
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: i915_suspend
results: parsing output: 34/ for test: gem_mmap
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_ctx_engines
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: gem_bad_reloc
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: gen7_exec_parse
results: parsing output: 44/ for test: i915_query
results: parsing output: 45/ for test: gem_spin_batch
results: parsing output: 46/ for test: gem_ctx_isolation
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: sw_sync
results: parsing output: 49/ for test: prime_busy
results: parsing output: 50/ for test: drm_read
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_set_tiling_vs_blt
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_tiled_blits
results: parsing output: 61/ for test: gem_mmap
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: gem_mmap_offset
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_vrr
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: kms_prop_blob
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_flink_basic
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_selftest
results: parsing output: 97/ for test: kms_pm_rpm
results: parsing output: 98/ for test: kms_getfb
results: parsing output: 99/ for test: gem_partial_pwrite_pread
results: parsing output: 100/ for test: gem_wait
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: gem_close
results: parsing output: 103/ for test: gem_pipe_control_store_loop
results: parsing output: 104/ for test: dmabuf_sync_file
results: parsing output: 105/ for test: kms_display_modes
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_mmap
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_pipe_crc_basic
results: parsing output: 113/ for test: kms_feature_discovery
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_busy
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: gem_lmem_swapping
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.