[59.015530] Initializing watchdogs
[59.015574]   /dev/watchdog0
[59.029734] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.033685] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.036209] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.039640] [001/132] (960s left) gem_exec_whisper (basic-queues-forked-all)
[59.133761] Starting subtest: basic-queues-forked-all
[81.059070] Subtest basic-queues-forked-all: SUCCESS (21.921s)
[81.239048] [002/132] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[81.329702] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[81.333727] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[81.420539] [003/132] (938s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[81.509289] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[82.655186] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.145s)
[82.786985] [004/132] (936s left) kms_atomic_interruptible (legacy-pageflip)
[82.866013] Starting subtest: legacy-pageflip
[82.868044] Starting dynamic subtest: pipe-A-eDP-1
[90.300817] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.432s)
[90.303137] Subtest legacy-pageflip: SUCCESS (7.433s)
[91.120592] [005/132] (928s left) kms_addfb_basic (master-rmfb)
[91.181903] Starting subtest: master-rmfb
[91.184241] Subtest master-rmfb: SUCCESS (0.001s)
[91.308012] [006/132] (928s left) gem_ppgtt (blt-vs-render-ctx0)
[91.360602] Starting subtest: blt-vs-render-ctx0
[124.256332] Subtest blt-vs-render-ctx0: SUCCESS (32.893s)
[124.374357] [007/132] (895s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[124.503048] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[125.340658] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.840s)
[125.509577] [008/132] (894s left) gem_mmap_gtt (fault-concurrent)
[125.581268] Subtest fault-concurrent: SKIP (0.000s)
[125.649833] [009/132] (894s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[125.726920] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[125.729307] Starting dynamic subtest: pipe-A-default-mode
[128.442903] Dynamic subtest pipe-A-default-mode: SUCCESS (2.715s)
[128.445292] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.716s)
[129.300938] [010/132] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[129.392639] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[136.867239] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.478s)
[136.979042] [011/132] (882s left) gem_tiled_swapping (non-threaded)
[137.030281] Subtest non-threaded: SKIP (0.000s)
[137.088124] [012/132] (882s left) kms_cursor_edge_walk (64x64-top-bottom)
[137.176563] Starting subtest: 64x64-top-bottom
[137.179054] Starting dynamic subtest: pipe-A-eDP-1
[140.610581] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.432s)
[140.619732] Starting dynamic subtest: pipe-D-eDP-1
[143.743697] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[143.745625] Subtest 64x64-top-bottom: SUCCESS (6.566s)
[144.553562] [013/132] (875s left) dmabuf_sync_file (import-multiple-read-only)
[144.681582] Starting subtest: import-multiple-read-only
[144.686650] Subtest import-multiple-read-only: SUCCESS (0.005s)
[144.737728] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[144.741070] [014/132] (875s left) gem_softpin (allocator-basic-reserve)
[144.807607] Starting subtest: allocator-basic-reserve
[144.876232] Subtest allocator-basic-reserve: SUCCESS (0.068s)
[144.987050] [015/132] (875s left) gem_mmap_offset (basic-uaf)
[145.037418] Starting subtest: basic-uaf
[145.039246] Subtest basic-uaf: SUCCESS (0.001s)
[145.136562] [016/132] (874s left) kms_flip (wf_vblank-ts-check-interruptible)
[145.208601] Starting subtest: wf_vblank-ts-check-interruptible
[145.210809] Starting dynamic subtest: A-eDP1
[154.105416] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[154.116113] Starting dynamic subtest: B-eDP1
[163.044923] Dynamic subtest B-eDP1: SUCCESS (8.938s)
[163.056065] Starting dynamic subtest: C-eDP1
[171.960704] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[171.972622] Starting dynamic subtest: D-eDP1
[180.883443] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[180.888082] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.678s)
[182.104753] [017/132] (838s left) gem_sync (basic-all)
[182.187642] Starting subtest: basic-all
[185.371549] Subtest basic-all: SUCCESS (3.195s)
[185.570386] [018/132] (834s left) kms_psr (psr2-dpms)
[185.643180] Starting subtest: psr2-dpms
[185.645403] Starting dynamic subtest: eDP-1
[188.539452] Dynamic subtest eDP-1: SUCCESS (2.896s)
[188.541739] Subtest psr2-dpms: SUCCESS (2.897s)
[189.410937] [019/132] (830s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[189.505630] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[198.832714] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.326s)
[199.633944] [020/132] (820s left) kms_psr (fbc-psr2-suspend)
[199.712143] Starting subtest: fbc-psr2-suspend
[199.714454] Starting dynamic subtest: eDP-1
[199.718664] Dynamic subtest eDP-1: SKIP (0.000s)
[199.722833] Subtest fbc-psr2-suspend: SKIP (0.001s)
[199.780915] [021/132] (820s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[199.859917] Starting subtest: plane-upscale-20x20-with-modifiers
[199.862285] Starting dynamic subtest: pipe-A
[200.196437] Dynamic subtest pipe-A: SUCCESS (0.338s)
[200.207034] Starting dynamic subtest: pipe-B
[201.620622] Dynamic subtest pipe-B: SUCCESS (1.424s)
[201.628708] Starting dynamic subtest: pipe-C
[203.054110] Dynamic subtest pipe-C: SUCCESS (1.433s)
[203.062182] Starting dynamic subtest: pipe-D
[204.481149] Dynamic subtest pipe-D: SUCCESS (1.426s)
[204.483405] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.624s)
[205.677549] [022/132] (814s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[205.758247] Starting subtest: pr-plane-move-sf-dmg-area
[205.762594] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[205.824066] [023/132] (814s left) perf_pmu (busy-idle-check-all)
[205.867683] Starting subtest: busy-idle-check-all
[205.869954] Starting dynamic subtest: rcs0
[206.529684] Dynamic subtest rcs0: SUCCESS (0.661s)
[206.540527] Starting dynamic subtest: bcs0
[207.178976] Dynamic subtest bcs0: SUCCESS (0.648s)
[207.189755] Starting dynamic subtest: vcs0
[208.856485] Dynamic subtest vcs0: SUCCESS (1.675s)
[208.868078] Starting dynamic subtest: vcs1
[210.841384] Dynamic subtest vcs1: SUCCESS (1.982s)
[210.853159] Starting dynamic subtest: vecs0
[212.825040] Dynamic subtest vecs0: SUCCESS (1.982s)
[212.837068] Starting dynamic subtest: ccs0
[213.480289] Dynamic subtest ccs0: SUCCESS (0.655s)
[213.482777] Subtest busy-idle-check-all: SUCCESS (7.613s)
[213.599562] [024/132] (806s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[213.703992] Starting subtest: cursorA-vs-flipB-atomic-transitions
[213.708661] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[213.843184] [025/132] (806s left) kms_color (ctm-green-to-red)
[213.927051] Starting subtest: ctm-green-to-red
[213.929140] Starting dynamic subtest: pipe-A-eDP-1
[214.609285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.683s)
[214.626773] Starting dynamic subtest: pipe-B-eDP-1
[216.010803] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[216.020121] Starting dynamic subtest: pipe-C-eDP-1
[217.295315] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s)
[217.305767] Starting dynamic subtest: pipe-D-eDP-1
[218.696434] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[218.698840] Subtest ctm-green-to-red: SUCCESS (4.772s)
[219.568651] [026/132] (800s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[219.654030] Starting subtest: psr-1p-pri-indfb-multidraw
[242.188387] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.538s)
[242.312121] [027/132] (778s left) vgem_slow (nohang)
[242.364488] Starting subtest: nohang
[252.471181] Subtest nohang: SUCCESS (10.105s)
[252.534576] [028/132] (768s left) syncobj_wait (wait-all-interrupted)
[252.600325] Starting subtest: wait-all-interrupted
[252.701834] Subtest wait-all-interrupted: SUCCESS (0.102s)
[252.793199] [029/132] (767s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[252.863262] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[252.871573] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.008s)
[252.961040] [030/132] (767s left) gem_tiled_fence_blits (basic)
[253.026607] Subtest basic: SKIP (0.000s)
[253.102388] [031/132] (767s left) api_intel_allocator (open-vm)
[253.157916] Starting subtest: open-vm
[253.160764] Subtest open-vm: SUCCESS (0.003s)
[253.275277] [032/132] (767s left) kms_atomic_interruptible (legacy-cursor)
[253.353698] Starting subtest: legacy-cursor
[253.355900] Starting dynamic subtest: pipe-A-eDP-1
[260.799240] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.446s)
[260.801606] Subtest legacy-cursor: SUCCESS (7.447s)
[261.649829] [033/132] (759s left) kms_plane_alpha_blend (constant-alpha-max)
[261.751311] Starting subtest: constant-alpha-max
[262.066559] Starting dynamic subtest: pipe-A-eDP-1
[263.143353] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.076s)
[263.153922] Starting dynamic subtest: pipe-D-eDP-1
[264.790420] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.645s)
[264.792787] Subtest constant-alpha-max: SUCCESS (3.040s)
[265.608407] [034/132] (755s left) kms_pm_rpm (modeset-lpsp-stress)
[267.119061] Starting subtest: modeset-lpsp-stress
[281.680066] Subtest modeset-lpsp-stress: SUCCESS (14.559s)
[281.768252] [035/132] (739s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[281.853350] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[281.858122] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[282.959389] [036/132] (737s left) kms_plane_cursor (primary)
[283.043154] Starting subtest: primary
[283.047496] Starting dynamic subtest: pipe-A-eDP-1-size-64
[285.685232] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.642s)
[285.708923] Starting dynamic subtest: pipe-A-eDP-1-size-128
[288.252917] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[288.275988] Starting dynamic subtest: pipe-A-eDP-1-size-256
[290.810168] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[291.125365] Starting dynamic subtest: pipe-B-eDP-1-size-64
[294.429068] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.313s)
[294.452387] Starting dynamic subtest: pipe-B-eDP-1-size-128
[297.018614] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[297.045162] Starting dynamic subtest: pipe-B-eDP-1-size-256
[299.576408] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.541s)
[299.892917] Starting dynamic subtest: pipe-C-eDP-1-size-64
[302.797684] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.915s)
[302.822989] Starting dynamic subtest: pipe-C-eDP-1-size-128
[305.021098] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.204s)
[305.045122] Starting dynamic subtest: pipe-C-eDP-1-size-256
[307.297035] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.258s)
[307.618711] Starting dynamic subtest: pipe-D-eDP-1-size-64
[310.533441] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.924s)
[310.559283] Starting dynamic subtest: pipe-D-eDP-1-size-128
[312.733183] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[312.759719] Starting dynamic subtest: pipe-D-eDP-1-size-256
[314.933219] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[315.242871] Subtest primary: SUCCESS (32.197s)
[316.095868] [037/132] (704s left) kms_psr (pr-sprite-render)
[316.175796] Starting subtest: pr-sprite-render
[316.179902] Subtest pr-sprite-render: SKIP (0.000s)
[316.247565] [038/132] (704s left) kms_addfb_basic (bad-pitch-65536)
[316.294450] Starting subtest: bad-pitch-65536
[316.296399] Subtest bad-pitch-65536: SUCCESS (0.000s)
[316.405535] [039/132] (704s left) gem_eio (banned)
[316.639530] Starting subtest: banned
[317.246391] Subtest banned: SUCCESS (0.609s)
[317.375592] [040/132] (703s left) kms_draw_crc (draw-method-mmap-gtt)
[317.443292] Starting subtest: draw-method-mmap-gtt
[317.446658] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[317.538097] [041/132] (703s left) prime_vgem (basic-fence-read)
[317.598496] Starting subtest: basic-fence-read
[317.613942] Subtest basic-fence-read: SKIP (0.013s)
[317.733352] [042/132] (703s left) gem_ctx_param (invalid-param-get)
[317.778426] Starting subtest: invalid-param-get
[317.780594] Subtest invalid-param-get: SUCCESS (0.001s)
[317.871260] [043/132] (703s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[317.939066] Starting subtest: crc-primary-basic-yf-tiled-ccs
[317.940877] Starting dynamic subtest: pipe-A-eDP-1
[317.959340] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[317.968645] Starting dynamic subtest: pipe-B-eDP-1
[317.986227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[317.994713] Starting dynamic subtest: pipe-C-eDP-1
[318.011689] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.021096] Starting dynamic subtest: pipe-D-eDP-1
[318.038751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.041966] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[320.171549] [044/132] (701s left) kms_psr (fbc-pr-primary-mmap-gtt)
[320.243741] Starting subtest: fbc-pr-primary-mmap-gtt
[320.248175] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[320.322740] [045/132] (700s left) gem_exec_balancer (sequential)
[320.377342] Starting subtest: sequential
[323.442593] Subtest sequential: SUCCESS (3.065s)
[323.741897] [046/132] (697s left) kms_content_protection (atomic-dpms-hdcp14)
[323.871948] Starting subtest: atomic-dpms-hdcp14
[323.876509] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[323.987138] [047/132] (697s left) gem_exec_schedule (preempt-contexts)
[324.057676] Starting subtest: preempt-contexts
[324.059581] Starting dynamic subtest: rcs0
[324.104099] Dynamic subtest rcs0: SUCCESS (0.053s)
[324.112874] Starting dynamic subtest: bcs0
[324.152647] Dynamic subtest bcs0: SUCCESS (0.048s)
[324.161535] Starting dynamic subtest: vcs0
[324.198737] Dynamic subtest vcs0: SUCCESS (0.045s)
[324.207593] Starting dynamic subtest: vcs1
[324.242510] Dynamic subtest vcs1: SUCCESS (0.043s)
[324.251561] Starting dynamic subtest: vecs0
[324.286381] Dynamic subtest vecs0: SUCCESS (0.043s)
[324.295217] Starting dynamic subtest: ccs0
[324.337811] Dynamic subtest ccs0: SUCCESS (0.051s)
[324.340095] Subtest preempt-contexts: SUCCESS (0.288s)
[325.952580] [048/132] (695s left) i915_selftest (live)
[329.205247] Starting subtest: live
[329.207795] Starting dynamic subtest: sanitycheck
[333.556443] Dynamic subtest sanitycheck: SUCCESS (4.350s)
[333.566182] Starting dynamic subtest: uncore
[337.859968] Dynamic subtest uncore: SUCCESS (4.302s)
[337.875712] Starting dynamic subtest: workarounds
[340.957914] Dynamic subtest workarounds: SUCCESS (3.095s)
[340.969488] Starting dynamic subtest: gt_engines
[343.958169] Dynamic subtest gt_engines: SUCCESS (2.998s)
[343.966707] Starting dynamic subtest: gt_timelines
[360.673082] Dynamic subtest gt_timelines: SUCCESS (16.712s)
[360.682673] Starting dynamic subtest: gt_contexts
[363.408197] Dynamic subtest gt_contexts: SUCCESS (2.733s)
[363.417042] Starting dynamic subtest: gt_lrc
[367.673354] Dynamic subtest gt_lrc: SUCCESS (4.263s)
[367.680703] Starting dynamic subtest: gt_mocs
[370.634987] Dynamic subtest gt_mocs: SUCCESS (2.958s)
[370.643426] Starting dynamic subtest: gt_pm
[377.375466] Dynamic subtest gt_pm: SUCCESS (6.738s)
[377.390277] Starting dynamic subtest: gt_heartbeat
[381.735252] Dynamic subtest gt_heartbeat: SUCCESS (4.357s)
[381.744473] Starting dynamic subtest: gt_tlb
[391.041888] Dynamic subtest gt_tlb: SUCCESS (9.303s)
[391.051727] Starting dynamic subtest: requests
[402.502505] Dynamic subtest requests: SUCCESS (11.458s)
[402.517626] Starting dynamic subtest: migrate
[410.216862] Dynamic subtest migrate: SUCCESS (7.713s)
[410.225050] Starting dynamic subtest: active
[414.487906] Dynamic subtest active: SUCCESS (4.268s)
[414.497298] Starting dynamic subtest: objects
[419.039219] Dynamic subtest objects: SUCCESS (4.549s)
[419.046954] Starting dynamic subtest: mman
[423.855326] Dynamic subtest mman: SUCCESS (4.813s)
[423.863681] Starting dynamic subtest: dmabuf
[426.593174] Dynamic subtest dmabuf: SUCCESS (2.736s)
[426.602684] Starting dynamic subtest: vma
[430.860641] Dynamic subtest vma: SUCCESS (4.266s)
[430.870939] Starting dynamic subtest: coherency
[434.451346] Dynamic subtest coherency: SUCCESS (3.589s)
[434.466084] Starting dynamic subtest: gtt
[443.922899] Dynamic subtest gtt: SUCCESS (9.469s)
[443.930433] Starting dynamic subtest: gem
[451.597874] Dynamic subtest gem: SUCCESS (7.672s)
[451.607863] Starting dynamic subtest: evict
[456.929237] Dynamic subtest evict: SUCCESS (5.330s)
[456.938447] Starting dynamic subtest: hugepages
[465.826583] Dynamic subtest hugepages: SUCCESS (8.895s)
[465.836223] Starting dynamic subtest: gem_contexts
[493.977340] Dynamic subtest gem_contexts: SUCCESS (28.148s)
[493.987367] Starting dynamic subtest: client
[496.771071] Dynamic subtest client: SUCCESS (2.793s)
[496.781120] Starting dynamic subtest: gem_migrate
[501.062309] Dynamic subtest gem_migrate: SUCCESS (4.290s)
[501.071037] Starting dynamic subtest: reset
[505.715976] Dynamic subtest reset: SUCCESS (4.651s)
[505.726240] Starting dynamic subtest: memory_region
[510.062357] Dynamic subtest memory_region: SUCCESS (4.344s)
[510.072747] Starting dynamic subtest: hangcheck
[522.801392] Dynamic subtest hangcheck: SUCCESS (12.736s)
[522.811560] Starting dynamic subtest: execlists
[527.061192] Dynamic subtest execlists: SUCCESS (4.259s)
[527.076573] Starting dynamic subtest: ring_submission
[531.389702] Dynamic subtest ring_submission: SUCCESS (4.313s)
[531.398986] Starting dynamic subtest: perf
[535.638818] Dynamic subtest perf: SUCCESS (4.259s)
[535.648624] Starting dynamic subtest: slpc
[549.618543] Dynamic subtest slpc: SUCCESS (13.977s)
[549.628430] Starting dynamic subtest: guc
[553.672364] Dynamic subtest guc: SUCCESS (4.051s)
[553.687882] Starting dynamic subtest: guc_multi_lrc
[558.019927] Dynamic subtest guc_multi_lrc: SUCCESS (4.345s)
[558.029566] Starting dynamic subtest: guc_hang
[562.827404] Dynamic subtest guc_hang: SUCCESS (4.805s)
[562.837338] Starting dynamic subtest: late_gt_pm
[565.501806] Dynamic subtest late_gt_pm: SUCCESS (2.673s)
[565.504521] Subtest live: SUCCESS (236.289s)
[565.533949] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[565.534661] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[565.537863] [049/132] (455s left) gem_pxp (protected-raw-src-copy-not-readible)
[567.248674] Starting subtest: protected-raw-src-copy-not-readible
[567.311809] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.064s)
[567.390718] [FACT gem_pxp (protected-raw-src-copy-not-readible)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[567.391761] [FACT gem_pxp (protected-raw-src-copy-not-readible)] new: kernel.kmod_is_loaded.i915: true
[567.396162] [050/132] (454s left) gem_exec_schedule (u-semaphore-user)
[567.476417] Starting subtest: u-semaphore-user
[567.528980] Subtest u-semaphore-user: SUCCESS (0.060s)
[568.895057] [051/132] (452s left) kms_cursor_crc (cursor-random-512x170)
[569.220487] Starting subtest: cursor-random-512x170
[569.225162] Subtest cursor-random-512x170: SKIP (0.002s)
[569.361241] [052/132] (452s left) gem_exec_whisper (basic-fds-priority-all)
[569.420814] Starting subtest: basic-fds-priority-all
[592.765554] Subtest basic-fds-priority-all: SUCCESS (23.342s)
[592.947152] [053/132] (428s left) kms_vblank (ts-continuation-suspend)
[593.027580] Starting subtest: ts-continuation-suspend
[593.029558] Starting dynamic subtest: pipe-A-eDP-1
[609.945228] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.711s)
[609.962418] Starting dynamic subtest: pipe-D-eDP-1
[626.980203] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.229s)
[626.983351] Subtest ts-continuation-suspend: SUCCESS (3.944s)
[627.786458] [054/132] (393s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[627.840067] Starting subtest: single-wait-for-submit-available-signaled
[627.842783] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[627.968829] [055/132] (393s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[628.045733] Starting subtest: fbc-1p-pri-indfb-multidraw
[640.964337] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.906s)
[642.354620] [056/132] (379s left) kms_rmfb (close-fd)
[642.430771] Starting subtest: close-fd
[642.433256] Starting dynamic subtest: pipe-A-eDP-1
[642.541708] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.111s)
[642.552941] Starting dynamic subtest: pipe-B-eDP-1
[643.710161] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[643.721298] Starting dynamic subtest: pipe-C-eDP-1
[644.857206] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.146s)
[644.867908] Starting dynamic subtest: pipe-D-eDP-1
[645.996301] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[645.999149] Subtest close-fd: SUCCESS (3.564s)
[647.109170] [057/132] (374s left) gem_ctx_persistence (legacy-engines-mixed)
[647.179647] Starting subtest: legacy-engines-mixed
[647.182176] Starting dynamic subtest: render
[647.255245] Dynamic subtest render: SUCCESS (0.075s)
[647.268064] Starting dynamic subtest: bsd1
[647.307287] Dynamic subtest bsd1: SUCCESS (0.050s)
[647.318321] Starting dynamic subtest: bsd2
[647.373498] Dynamic subtest bsd2: SUCCESS (0.065s)
[647.385207] Starting dynamic subtest: blt
[647.433670] Dynamic subtest blt: SUCCESS (0.058s)
[647.444950] Starting dynamic subtest: vebox
[647.496440] Dynamic subtest vebox: SUCCESS (0.060s)
[647.499187] Subtest legacy-engines-mixed: SUCCESS (0.318s)
[647.580098] [058/132] (374s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[647.688080] Starting subtest: basic-flip-after-cursor-atomic
[648.647139] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.956s)
[649.445195] [059/132] (372s left) kms_getfb (getfb2-into-addfb2)
[649.518620] Starting subtest: getfb2-into-addfb2
[649.521112] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[649.608310] [060/132] (372s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[649.672670] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[649.677942] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[649.863903] [061/132] (372s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[649.945326] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[654.154721] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.213s)
[655.348672] [062/132] (366s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[655.429989] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[656.497896] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.068s)
[656.611871] [063/132] (365s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[656.695587] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[656.698025] Starting dynamic subtest: pipe-A-eDP-1
[662.617059] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.922s)
[662.628234] Starting dynamic subtest: pipe-B-eDP-1
[669.246155] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.625s)
[669.248993] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.550s)
[670.130854] [064/132] (351s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[670.219045] Starting subtest: primary-4-tiled-reflect-x-0
[677.530447] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.311s)
[678.688654] [065/132] (343s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[678.770050] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[678.772362] Starting dynamic subtest: pipe-A-default-mode
[681.530757] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s)
[681.533319] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.762s)
[682.389815] [066/132] (339s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[682.493194] Starting subtest: short-flip-before-cursor-atomic-transitions
[683.441606] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.948s)
[684.330687] [067/132] (337s left) api_intel_bb (delta-check)
[684.390023] Starting subtest: delta-check
[684.395805] Subtest delta-check: SUCCESS (0.007s)
[684.514332] [068/132] (337s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[684.596087] Starting subtest: plane-primary-overlay-mutable-zpos
[688.067532] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.469s)
[689.261115] [069/132] (332s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[689.338110] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[689.342734] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[689.407180] [070/132] (332s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[689.786158] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[690.580467] [071/132] (331s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[690.658649] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[697.205361] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.548s)
[697.341874] [072/132] (325s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[697.421043] Starting subtest: y-tiled-32bpp-rotate-90
[697.425349] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[697.516230] [073/132] (324s left) gem_bad_reloc (negative-reloc-lut)
[697.573529] Subtest negative-reloc-lut: SKIP (0.000s)
[697.651591] [074/132] (324s left) gem_cs_tlb (engines)
[697.711100] Starting subtest: engines
[697.714228] Starting dynamic subtest: rcs0
[699.870149] Dynamic subtest rcs0: SUCCESS (2.154s)
[699.883093] Starting dynamic subtest: bcs0
[702.024289] Dynamic subtest bcs0: SUCCESS (2.152s)
[702.038127] Starting dynamic subtest: vcs0
[704.180649] Dynamic subtest vcs0: SUCCESS (2.154s)
[704.190918] Starting dynamic subtest: vcs1
[706.336462] Dynamic subtest vcs1: SUCCESS (2.154s)
[706.346561] Starting dynamic subtest: vecs0
[708.489836] Dynamic subtest vecs0: SUCCESS (2.152s)
[708.499753] Starting dynamic subtest: ccs0
[710.646377] Dynamic subtest ccs0: SUCCESS (2.154s)
[710.648854] Subtest engines: SUCCESS (12.926s)
[710.761949] [075/132] (311s left) kms_properties (invalid-properties-legacy)
[710.839702] Starting subtest: invalid-properties-legacy
[710.931915] Subtest invalid-properties-legacy: SUCCESS (0.094s)
[711.013055] [076/132] (311s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[711.099625] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[711.102004] Starting dynamic subtest: pipe-A-eDP-1
[711.128698] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[711.139028] Starting dynamic subtest: pipe-B-eDP-1
[711.167194] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[711.176940] Starting dynamic subtest: pipe-C-eDP-1
[711.205963] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[711.215530] Starting dynamic subtest: pipe-D-eDP-1
[711.243998] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[711.248884] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[713.304705] [077/132] (309s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[713.366174] Starting subtest: multi-wait-for-submit-available-submitted
[713.369080] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[713.454540] [078/132] (309s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[713.531876] Starting subtest: primary-yf-tiled-reflect-x-0
[713.590886] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[713.697651] [079/132] (308s left) kms_pm_rpm (basic-pci-d3-state)
[715.193674] Starting subtest: basic-pci-d3-state
[716.673080] Subtest basic-pci-d3-state: SUCCESS (1.477s)
[716.775866] [080/132] (305s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[716.854641] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[716.859862] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[716.958832] [081/132] (305s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[717.041788] Starting subtest: 4-tiled-64bpp-rotate-180
[719.028803] Subtest 4-tiled-64bpp-rotate-180: FAIL (1.286s)
[719.068227] [082/132] (303s left) gem_readwrite (read-bad-handle)
[719.126200] Subtest read-bad-handle: SKIP (0.000s)
[719.179610] [083/132] (303s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[719.269044] Starting subtest: yf-tiled-addfb-size-overflow
[719.273615] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[719.361707] [084/132] (303s left) gen9_exec_parse (bb-chained)
[719.421922] Subtest bb-chained: SKIP (0.000s)
[719.488086] [085/132] (303s left) i915_hangman (engine-error-state-capture)
[719.548835] Starting subtest: engine-error-state-capture
[719.550817] Starting dynamic subtest: rcs0
[722.797158] Dynamic subtest rcs0: SUCCESS (3.246s)
[722.810111] Starting dynamic subtest: bcs0
[728.813870] Dynamic subtest bcs0: SUCCESS (6.019s)
[728.826672] Starting dynamic subtest: vcs0
[734.765974] Dynamic subtest vcs0: SUCCESS (5.953s)
[734.779332] Starting dynamic subtest: vcs1
[739.756363] Dynamic subtest vcs1: SUCCESS (4.990s)
[739.770300] Starting dynamic subtest: vecs0
[744.749339] Dynamic subtest vecs0: SUCCESS (4.991s)
[744.763118] Starting dynamic subtest: ccs0
[749.804701] Dynamic subtest ccs0: SUCCESS (5.054s)
[749.807694] Subtest engine-error-state-capture: SUCCESS (30.270s)
[749.925802] [086/132] (273s left) gem_exec_fence (syncobj-invalid-flags)
[750.405908] Starting subtest: syncobj-invalid-flags
[750.408474] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[751.901526] [087/132] (271s left) gem_exec_schedule (smoketest-all)
[751.979126] Starting subtest: smoketest-all
[784.413080] Subtest smoketest-all: SUCCESS (32.381s)
[785.910144] [088/132] (237s left) kms_invalid_mode (bad-hsync-end)
[785.991058] Starting subtest: bad-hsync-end
[785.993606] Starting dynamic subtest: pipe-A-eDP-1
[786.273743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[786.285623] Starting dynamic subtest: pipe-B-eDP-1
[786.288071] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[786.299921] Starting dynamic subtest: pipe-C-eDP-1
[786.302341] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[786.312126] Starting dynamic subtest: pipe-D-eDP-1
[786.314908] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[786.317476] Subtest bad-hsync-end: SUCCESS (0.291s)
[787.131447] [089/132] (235s left) gem_exec_schedule (implicit-boths)
[787.197792] Starting subtest: implicit-boths
[787.200087] Starting dynamic subtest: rcs0
[787.331326] Dynamic subtest rcs0: SUCCESS (0.146s)
[787.349313] Starting dynamic subtest: vcs0
[787.423950] Dynamic subtest vcs0: SUCCESS (0.090s)
[787.437472] Starting dynamic subtest: vcs1
[787.517053] Dynamic subtest vcs1: SUCCESS (0.093s)
[787.529356] Starting dynamic subtest: vecs0
[787.596962] Dynamic subtest vecs0: SUCCESS (0.079s)
[787.609942] Starting dynamic subtest: ccs0
[787.685324] Dynamic subtest ccs0: SUCCESS (0.088s)
[787.688365] Subtest implicit-boths: SUCCESS (0.500s)
[788.967669] [090/132] (234s left) kms_properties (plane-properties-atomic)
[789.045514] Starting subtest: plane-properties-atomic
[789.047938] Starting dynamic subtest: pipe-A-eDP-1
[789.606083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[789.618054] Starting dynamic subtest: pipe-B-eDP-1
[790.912474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[790.923572] Starting dynamic subtest: pipe-C-eDP-1
[792.154163] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[792.166903] Starting dynamic subtest: pipe-D-eDP-1
[793.383303] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[793.386335] Subtest plane-properties-atomic: SUCCESS (4.340s)
[794.182689] [091/132] (228s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[794.259079] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[794.261973] Starting dynamic subtest: pipe-A-eDP-1
[794.286177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[794.298417] Starting dynamic subtest: pipe-B-eDP-1
[794.321324] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[794.330877] Starting dynamic subtest: pipe-C-eDP-1
[794.354057] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[794.363097] Starting dynamic subtest: pipe-D-eDP-1
[794.386782] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[794.389104] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[796.552493] [092/132] (226s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[796.632813] Starting subtest: fbc-rgb101010-draw-pwrite
[802.010782] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.382s)
[803.156545] [093/132] (220s left) prime_self_import (basic-llseek-bad)
[803.202164] Starting subtest: basic-llseek-bad
[803.233327] Subtest basic-llseek-bad: SUCCESS (0.028s)
[803.324902] [094/132] (219s left) kms_plane (pixel-format-linear-modifier)
[803.412037] Starting subtest: pixel-format-linear-modifier
[803.438942] Starting dynamic subtest: pipe-A-plane-0
[806.915968] Dynamic subtest pipe-A-plane-0: SUCCESS (3.477s)
[806.926206] Starting dynamic subtest: pipe-A-plane-3
[808.649917] Dynamic subtest pipe-A-plane-3: SUCCESS (1.733s)
[808.660856] Starting dynamic subtest: pipe-A-plane-5
[808.860829] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[809.945129] Starting dynamic subtest: pipe-B-plane-0
[813.656950] Dynamic subtest pipe-B-plane-0: SUCCESS (3.722s)
[813.670476] Starting dynamic subtest: pipe-B-plane-3
[815.579937] Dynamic subtest pipe-B-plane-3: SUCCESS (1.920s)
[815.591150] Starting dynamic subtest: pipe-B-plane-5
[815.790738] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[816.116213] Subtest pixel-format-linear-modifier: SUCCESS (12.702s)
[816.927717] [095/132] (206s left) kms_plane (plane-position-hole)
[816.998894] Starting subtest: plane-position-hole
[817.526976] Starting dynamic subtest: pipe-A-plane-1
[818.797169] Dynamic subtest pipe-A-plane-1: SUCCESS (1.271s)
[818.810997] Starting dynamic subtest: pipe-A-plane-2
[820.010045] Dynamic subtest pipe-A-plane-2: SUCCESS (1.212s)
[820.021294] Starting dynamic subtest: pipe-A-plane-3
[821.248737] Dynamic subtest pipe-A-plane-3: SUCCESS (1.236s)
[821.261637] Starting dynamic subtest: pipe-A-plane-4
[822.482809] Dynamic subtest pipe-A-plane-4: SUCCESS (1.235s)
[822.493671] Starting dynamic subtest: pipe-A-plane-5
[822.510166] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[823.647351] Starting dynamic subtest: pipe-B-plane-1
[824.963188] Dynamic subtest pipe-B-plane-1: SUCCESS (1.325s)
[824.973201] Starting dynamic subtest: pipe-B-plane-2
[826.192935] Dynamic subtest pipe-B-plane-2: SUCCESS (1.225s)
[826.204326] Starting dynamic subtest: pipe-B-plane-3
[827.432919] Dynamic subtest pipe-B-plane-3: SUCCESS (1.237s)
[827.444018] Starting dynamic subtest: pipe-B-plane-4
[828.679837] Dynamic subtest pipe-B-plane-4: SUCCESS (1.248s)
[828.691354] Starting dynamic subtest: pipe-B-plane-5
[828.708217] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[828.711203] Subtest plane-position-hole: SUCCESS (11.704s)
[829.480560] [096/132] (193s left) gem_softpin (overlap)
[829.554868] Starting subtest: overlap
[830.382053] Subtest overlap: SUCCESS (0.826s)
[830.495958] [097/132] (192s left) syncobj_eventfd (invalid-bad-flags)
[830.554547] Starting subtest: invalid-bad-flags
[830.557116] Subtest invalid-bad-flags: SUCCESS (0.000s)
[830.642721] [098/132] (192s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[830.718701] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[830.724114] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[830.815246] [099/132] (192s left) gem_userptr_blits (vma-merge)
[830.887730] Starting subtest: vma-merge
[830.926839] Subtest vma-merge: SUCCESS (0.039s)
[831.034695] [100/132] (192s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[831.107130] Starting subtest: psr-2p-pri-indfb-multidraw
[831.112240] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[831.197687] [101/132] (192s left) syncobj_timeline (wait-zero-handles)
[831.253826] Starting subtest: wait-zero-handles
[831.256605] Subtest wait-zero-handles: SUCCESS (0.000s)
[831.356599] [102/132] (192s left) kms_cursor_crc (cursor-onscreen-64x64)
[831.505936] Starting subtest: cursor-onscreen-64x64
[831.511431] Starting dynamic subtest: pipe-A-eDP-1
[833.620344] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[833.652074] Starting dynamic subtest: pipe-D-eDP-1
[836.372621] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.728s)
[836.375252] Subtest cursor-onscreen-64x64: SUCCESS (4.863s)
[837.172202] [103/132] (186s left) gem_softpin (evict-snoop)
[837.233736] Starting subtest: evict-snoop
[837.239111] Subtest evict-snoop: SKIP (0.000s)
[837.346138] [104/132] (186s left) gem_ctx_freq (sysfs)
[837.407198] Starting subtest: sysfs
[837.409979] Starting dynamic subtest: gt0
[842.924689] Dynamic subtest gt0: SUCCESS (5.515s)
[842.937582] Starting dynamic subtest: gt1
[884.879020] Dynamic subtest gt1: SUCCESS (41.958s)
[884.882578] Subtest sysfs: SUCCESS (47.476s)
[884.995723] [105/132] (138s left) kms_sequence (queue-busy)
[885.074350] Starting subtest: queue-busy
[885.077303] Starting dynamic subtest: pipe-A-eDP-1
[887.020473] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s)
[887.031527] Starting dynamic subtest: pipe-B-eDP-1
[889.661324] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.638s)
[889.672327] Starting dynamic subtest: pipe-C-eDP-1
[892.288781] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.625s)
[892.299783] Starting dynamic subtest: pipe-D-eDP-1
[894.887171] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[894.890254] Subtest queue-busy: SUCCESS (9.817s)
[895.670398] [106/132] (128s left) gem_exec_capture (userptr)
[895.733258] Starting subtest: userptr
[896.561110] Subtest userptr: SUCCESS (0.829s)
[896.672874] [107/132] (127s left) gem_exec_reloc (basic-write-wc-active)
[896.741810] Subtest basic-write-wc-active: SKIP (0.000s)
[896.816969] [108/132] (127s left) kms_chamelium_frames (hdmi-aspect-ratio)
[897.183041] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[897.973916] [109/132] (125s left) i915_drm_fdinfo (busy-hang)
[898.022362] Starting subtest: busy-hang
[898.025154] Starting dynamic subtest: rcs0
[898.049097] Dynamic subtest rcs0: SKIP (0.024s)
[898.061355] Starting dynamic subtest: bcs0
[898.066929] Dynamic subtest bcs0: SKIP (0.002s)
[898.076726] Starting dynamic subtest: vcs0
[898.082209] Dynamic subtest vcs0: SKIP (0.001s)
[898.092197] Starting dynamic subtest: vcs1
[898.097474] Dynamic subtest vcs1: SKIP (0.001s)
[898.107181] Starting dynamic subtest: vecs0
[898.112215] Dynamic subtest vecs0: SKIP (0.000s)
[898.121697] Starting dynamic subtest: ccs0
[898.126841] Dynamic subtest ccs0: SKIP (0.001s)
[898.131831] Subtest busy-hang: SKIP (0.042s)
[898.170183] [110/132] (125s left) kms_lease (implicit-plane-lease)
[898.250199] Starting subtest: implicit-plane-lease
[898.252965] Subtest implicit-plane-lease: SUCCESS (0.003s)
[898.355316] [111/132] (125s left) gem_exec_reloc (basic-wc-cpu-active)
[898.416455] Subtest basic-wc-cpu-active: SKIP (0.000s)
[898.471637] [112/132] (125s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[898.545554] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[898.550205] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[898.636532] [113/132] (125s left) gem_shrink (reclaim)
[898.688691] Starting subtest: reclaim
[901.124015] Subtest reclaim: SUCCESS (2.436s)
[901.283343] [114/132] (122s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[901.376943] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[901.382199] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[901.476287] [115/132] (122s left) kms_vrr (seamless-rr-switch-drrs)
[901.555913] Starting subtest: seamless-rr-switch-drrs
[901.564163] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[901.656446] [116/132] (122s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[901.711558] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[901.788357] [117/132] (122s left) gem_exec_balancer (nohangcheck)
[902.045210] Starting subtest: nohangcheck
[902.924278] Subtest nohangcheck: SUCCESS (0.879s)
[903.042932] [118/132] (121s left) gem_readwrite (beyond-eob)
[903.097148] Subtest beyond-EOB: SKIP (0.000s)
[903.155060] [119/132] (121s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[903.218250] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[903.305332] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[903.345307] [120/132] (121s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[903.424105] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[903.429522] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[903.543319] [121/132] (120s left) gem_mmap_offset (pf-nonblock)
[903.603030] Starting subtest: pf-nonblock
[903.609130] Subtest pf-nonblock: SUCCESS (0.008s)
[903.723137] [122/132] (120s left) syncobj_timeline (etime-multi-wait-submitted)
[903.784138] Starting subtest: etime-multi-wait-submitted
[903.892299] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[903.968935] [123/132] (120s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[904.044318] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[904.047010] Starting dynamic subtest: pipe-A-eDP-1
[904.056875] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[904.069809] Starting dynamic subtest: pipe-B-eDP-1
[904.079848] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[904.089877] Starting dynamic subtest: pipe-C-eDP-1
[904.100100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[904.109965] Starting dynamic subtest: pipe-D-eDP-1
[904.120598] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[904.125736] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[906.278499] [124/132] (118s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[906.359890] Starting subtest: extended-pageflip-modeset-hang-oldfb
[906.362918] Starting dynamic subtest: pipe-A
[914.276266] Dynamic subtest pipe-A: SUCCESS (7.915s)
[914.288344] Starting dynamic subtest: pipe-D
[922.889914] Dynamic subtest pipe-D: SUCCESS (8.609s)
[922.892454] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.529s)
[923.729438] [125/132] (100s left) kms_properties (crtc-properties-legacy)
[923.809307] Starting subtest: crtc-properties-legacy
[923.812122] Starting dynamic subtest: pipe-A-eDP-1
[924.251698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[924.262050] Starting dynamic subtest: pipe-B-eDP-1
[925.387676] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.136s)
[925.398318] Starting dynamic subtest: pipe-C-eDP-1
[926.505858] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[926.517325] Starting dynamic subtest: pipe-D-eDP-1
[927.651128] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[927.653564] Subtest crtc-properties-legacy: SUCCESS (3.843s)
[928.452333] [126/132] ( 96s left) gem_mmap_gtt (cpuset-basic-small-copy)
[928.521738] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[928.578908] [127/132] ( 96s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[930.068710] Starting subtest: gem-execbuf-stress-pc8
[930.113795] Subtest gem-execbuf-stress-pc8: SKIP (0.042s)
[930.780334] [128/132] ( 93s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[930.896325] Starting subtest: short-busy-flip-before-cursor-toggle
[930.901010] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[931.042648] [129/132] ( 93s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[931.124160] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[937.900293] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.779s)
[938.036527] [130/132] ( 86s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[938.086080] Starting subtest: invalid-single-wait-all-unsubmitted
[938.088808] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[938.186743] [131/132] ( 86s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[938.259134] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[938.264089] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[938.366678] [132/132] ( 86s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[938.440828] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[938.445916] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[938.534532] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_whisper
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_atomic_interruptible
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: gem_ppgtt
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_tiled_swapping
results: parsing output: 11/ for test: kms_cursor_edge_walk
results: parsing output: 12/ for test: dmabuf_sync_file
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_sync
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: vgem_slow
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_tiled_fence_blits
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_plane_cursor
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: kms_draw_crc
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: gem_ctx_param
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: i915_selftest
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_rmfb
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: api_intel_bb
results: parsing output: 67/ for test: kms_atomic
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_bad_reloc
results: parsing output: 73/ for test: gem_cs_tlb
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_pm_rpm
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_readwrite
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gen9_exec_parse
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_invalid_mode
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_properties
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: prime_self_import
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: syncobj_eventfd
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: gem_ctx_freq
results: parsing output: 104/ for test: kms_sequence
results: parsing output: 105/ for test: gem_exec_capture
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_chamelium_frames
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_lease
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_shrink
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: gem_readwrite
results: parsing output: 118/ for test: sriov_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_mmap_offset
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_busy
results: parsing output: 124/ for test: kms_properties
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.