[58.773375] Initializing watchdogs
[58.773422]   /dev/watchdog0
[58.789050] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.793072] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.795060] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.798413] [001/131] (960s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[58.938805] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[60.401050] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.442s)
[61.287464] [002/131] (958s left) kms_pwrite_crc (basic)
[61.369709] Starting subtest: basic
[62.070463] Subtest basic: SUCCESS (0.693s)
[62.928665] [003/131] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[63.021359] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[63.025380] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[63.125709] [004/131] (956s left) gem_pxp (verify-pxp-stale-buf-execution)
[63.250582] Starting subtest: verify-pxp-stale-buf-execution
[64.317359] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.059s)
[64.427865] [005/131] (955s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[64.526697] Starting subtest: cursorB-vs-flipA-varying-size
[64.531258] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[64.680991] [006/131] (954s left) syncobj_timeline (wait-any-snapshot)
[64.737891] Starting subtest: wait-any-snapshot
[64.819246] Subtest wait-any-snapshot: SUCCESS (0.081s)
[64.892171] [007/131] (954s left) kms_invalid_mode (zero-clock)
[64.972679] Starting subtest: zero-clock
[64.974984] Starting dynamic subtest: pipe-A-eDP-1
[65.257428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[65.266949] Starting dynamic subtest: pipe-B-eDP-1
[65.268938] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[65.276428] Starting dynamic subtest: pipe-C-eDP-1
[65.278810] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[65.286646] Starting dynamic subtest: pipe-D-eDP-1
[65.288658] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[65.290606] Subtest zero-clock: SUCCESS (0.289s)
[66.083911] [008/131] (953s left) kms_pm_rpm (pc8-residency)
[68.394574] Starting subtest: pc8-residency
[68.399563] Subtest pc8-residency: SKIP (0.000s)
[68.764656] [009/131] (950s left) kms_rotation_crc (sprite-rotation-90)
[68.837208] Starting subtest: sprite-rotation-90
[68.841882] Subtest sprite-rotation-90: SKIP (0.001s)
[68.920734] [010/131] (950s left) kms_properties (plane-properties-legacy)
[68.999038] Starting subtest: plane-properties-legacy
[69.001341] Starting dynamic subtest: pipe-A-eDP-1
[69.537286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.535s)
[69.545826] Starting dynamic subtest: pipe-B-eDP-1
[70.838195] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.298s)
[70.847631] Starting dynamic subtest: pipe-C-eDP-1
[72.069949] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[72.078571] Starting dynamic subtest: pipe-D-eDP-1
[73.304116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[73.306427] Subtest plane-properties-legacy: SUCCESS (4.294s)
[74.105350] [011/131] (945s left) gem_exec_fence (invalid-timeline-fence-array)
[74.652387] Starting subtest: invalid-timeline-fence-array
[74.658606] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[76.301722] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[76.305171] [012/131] (943s left) drm_read (short-buffer-block)
[76.429051] Starting subtest: short-buffer-block
[76.431442] Subtest short-buffer-block: SUCCESS (0.000s)
[76.556191] [013/131] (943s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[76.610074] Starting subtest: single-wait-for-submit-available-signaled
[76.612542] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[76.704313] [014/131] (943s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[76.757607] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[76.762302] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[76.935439] [015/131] (942s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[77.019348] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[77.021829] Starting dynamic subtest: pipe-A
[77.356427] Dynamic subtest pipe-A: SUCCESS (0.338s)
[77.364930] Starting dynamic subtest: pipe-B
[78.806158] Dynamic subtest pipe-B: SUCCESS (1.447s)
[78.814513] Starting dynamic subtest: pipe-C
[80.236362] Dynamic subtest pipe-C: SUCCESS (1.429s)
[80.245017] Starting dynamic subtest: pipe-D
[81.671487] Dynamic subtest pipe-D: SUCCESS (1.433s)
[81.673923] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.649s)
[82.844823] [016/131] (937s left) kms_sequence (get-busy)
[82.921396] Starting subtest: get-busy
[82.923878] Starting dynamic subtest: pipe-A-eDP-1
[84.866418] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[84.875156] Starting dynamic subtest: pipe-B-eDP-1
[87.452871] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[87.462815] Starting dynamic subtest: pipe-C-eDP-1
[90.061582] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[90.071713] Starting dynamic subtest: pipe-D-eDP-1
[92.682361] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[92.684525] Subtest get-busy: SUCCESS (9.758s)
[93.568210] [017/131] (926s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[93.628827] Starting subtest: rel-constants-invalid-rel-gen5
[93.631172] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[93.730504] [018/131] (926s left) syncobj_wait (multi-wait-all-submitted)
[93.783639] Starting subtest: multi-wait-all-submitted
[93.890355] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[93.966854] [019/131] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[94.039851] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[94.044391] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[94.145651] [020/131] (925s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[94.223639] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[94.225994] Starting dynamic subtest: pipe-A-eDP-1
[94.235362] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[94.245490] Starting dynamic subtest: pipe-B-eDP-1
[94.254623] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[94.262615] Starting dynamic subtest: pipe-C-eDP-1
[94.271196] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[94.279684] Starting dynamic subtest: pipe-D-eDP-1
[94.288278] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[94.292319] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[96.530343] [021/131] (923s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[96.612531] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[96.616671] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[96.698723] [022/131] (923s left) kms_pm_lpsp (kms-lpsp)
[97.781705] Starting subtest: kms-lpsp
[97.784181] Starting dynamic subtest: pipe-A-eDP-1
[97.929606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[98.236170] Subtest kms-lpsp: SUCCESS (0.456s)
[99.064150] [023/131] (921s left) gem_eio (wait-1us)
[99.259630] Starting subtest: wait-1us
[99.550922] Subtest wait-1us: SUCCESS (0.292s)
[99.693377] [024/131] (920s left) gem_mmap_offset (mmap-boundaries)
[99.753812] Starting subtest: mmap-boundaries
[99.755751] Starting dynamic subtest: smem0
[100.025056] Dynamic subtest smem0: SUCCESS (0.272s)
[100.028037] Subtest mmap-boundaries: SUCCESS (0.273s)
[100.161695] [025/131] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[100.240379] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[100.245131] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[100.331234] [026/131] (919s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[100.385034] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[100.387314] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[100.492520] [027/131] (919s left) gem_ctx_persistence (heartbeat-stop)
[100.554595] Starting subtest: heartbeat-stop
[100.559048] Subtest heartbeat-stop: SKIP (0.000s)
[100.652731] [028/131] (919s left) i915_pm_rpm (gem-execbuf-stress)
[102.358613] Starting subtest: gem-execbuf-stress
[102.361685] Starting dynamic subtest: smem0
[115.184340] Dynamic subtest smem0: SUCCESS (12.824s)
[115.194795] Starting dynamic subtest: extra-wait-smem0
[177.138764] Dynamic subtest extra-wait-smem0: SUCCESS (61.946s)
[177.141873] Subtest gem-execbuf-stress: SUCCESS (74.773s)
[177.526210] [029/131] (842s left) kms_plane (pixel-format-y-tiled-modifier)
[177.598817] Starting subtest: pixel-format-y-tiled-modifier
[177.603117] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[177.670499] [030/131] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[177.752914] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[177.757281] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[177.851729] [031/131] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[177.938750] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[177.942682] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[178.026498] [032/131] (842s left) kms_plane_multiple (2x-tiling-y)
[178.095371] Starting subtest: 2x-tiling-y
[178.099882] Subtest 2x-tiling-y: SKIP (0.000s)
[178.163468] [033/131] (842s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[178.248335] Starting subtest: yf-tiled-16bpp-rotate-180
[178.252436] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[178.357160] [034/131] (842s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[178.418433] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[178.421360] Starting dynamic subtest: pipe-A-eDP-1
[178.448315] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[178.459235] Starting dynamic subtest: pipe-B-eDP-1
[178.476656] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[178.484502] Starting dynamic subtest: pipe-C-eDP-1
[178.501921] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[178.509667] Starting dynamic subtest: pipe-D-eDP-1
[178.527792] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[178.531306] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[180.658463] [035/131] (839s left) kms_lease (lease-unleased-connector)
[180.731775] Starting subtest: lease-unleased-connector
[180.734495] Starting dynamic subtest: pipe-A-eDP-1
[180.737124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[180.750268] Starting dynamic subtest: pipe-B-eDP-1
[180.752506] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[180.761502] Starting dynamic subtest: pipe-C-eDP-1
[180.763342] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[180.771295] Starting dynamic subtest: pipe-D-eDP-1
[180.773122] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[180.774923] Subtest lease-unleased-connector: SUCCESS (0.029s)
[180.874286] [036/131] (839s left) prime_self_import (basic-llseek-bad)
[180.905764] Starting subtest: basic-llseek-bad
[180.925122] Subtest basic-llseek-bad: SUCCESS (0.018s)
[181.030242] [037/131] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[181.111292] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[188.159575] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.053s)
[188.271293] [038/131] (832s left) perf (mi-rpc)
[188.403267] Starting subtest: mi-rpc
[188.407266] Subtest mi-rpc: SKIP (0.000s)
[188.447720] [039/131] (832s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[188.539213] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[192.629945] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.096s)
[193.824295] [040/131] (827s left) kms_draw_crc (draw-method-blt)
[193.889912] Starting subtest: draw-method-blt
[193.892231] Starting dynamic subtest: xrgb8888-untiled
[194.145051] Dynamic subtest xrgb8888-untiled: SUCCESS (0.256s)
[194.154691] Starting dynamic subtest: rgb565-untiled
[194.367419] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[194.377929] Starting dynamic subtest: xrgb2101010-untiled
[194.578911] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[194.590222] Starting dynamic subtest: xbgr16161616f-untiled
[194.789085] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[194.797824] Starting dynamic subtest: xrgb8888-xtiled
[194.900245] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[194.911443] Starting dynamic subtest: rgb565-xtiled
[195.011178] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[195.020688] Starting dynamic subtest: xrgb2101010-xtiled
[195.123874] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[195.133555] Starting dynamic subtest: xbgr16161616f-xtiled
[195.233250] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[195.241784] Starting dynamic subtest: xrgb8888-4tiled
[195.355820] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[195.364734] Starting dynamic subtest: rgb565-4tiled
[195.456071] Dynamic subtest rgb565-4tiled: SUCCESS (0.100s)
[195.465082] Starting dynamic subtest: xrgb2101010-4tiled
[195.567078] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[195.581642] Starting dynamic subtest: xbgr16161616f-4tiled
[195.678042] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[195.680204] Subtest draw-method-blt: SUCCESS (1.789s)
[195.809209] [041/131] (825s left) gem_exec_suspend (basic-s3-devices)
[195.872616] Starting subtest: basic-S3-devices
[195.874923] Starting dynamic subtest: smem
[207.165682] Dynamic subtest smem: SUCCESS (11.294s)
[207.168415] Subtest basic-S3-devices: SUCCESS (11.295s)
[207.350333] [042/131] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[207.447424] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[207.451507] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[207.544886] [043/131] (813s left) gem_exec_capture (userptr)
[207.598881] Starting subtest: userptr
[208.436864] Subtest userptr: SUCCESS (0.837s)
[208.557674] [044/131] (812s left) kms_big_fb (4-tiled-addfb-size-overflow)
[208.644308] Starting subtest: 4-tiled-addfb-size-overflow
[208.646594] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.001s)
[208.753154] [045/131] (812s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[208.821382] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[208.823328] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[208.931470] [046/131] (812s left) gen9_exec_parse (bb-start-out)
[208.992725] Subtest bb-start-out: SKIP (0.000s)
[209.066948] [047/131] (812s left) gem_exec_fence (basic-wait)
[209.247441] Starting subtest: basic-wait
[209.249909] Starting dynamic subtest: rcs0
[209.340241] Dynamic subtest rcs0: SUCCESS (0.096s)
[209.351420] Starting dynamic subtest: bcs0
[209.398340] Dynamic subtest bcs0: SUCCESS (0.057s)
[209.410217] Starting dynamic subtest: vcs0
[209.454069] Dynamic subtest vcs0: SUCCESS (0.054s)
[209.465499] Starting dynamic subtest: vcs1
[209.512068] Dynamic subtest vcs1: SUCCESS (0.056s)
[209.523446] Starting dynamic subtest: vecs0
[209.570071] Dynamic subtest vecs0: SUCCESS (0.056s)
[209.581453] Starting dynamic subtest: ccs0
[209.637725] Dynamic subtest ccs0: SUCCESS (0.066s)
[209.640419] Subtest basic-wait: SUCCESS (0.394s)
[211.255478] [048/131] (809s left) i915_suspend (fence-restore-tiled2untiled)
[211.313339] Starting subtest: fence-restore-tiled2untiled
[211.317073] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[211.401842] [049/131] (809s left) kms_chamelium_color (ctm-max)
[211.486913] Subtest ctm-max: SKIP (0.000s)
[211.530450] [050/131] (809s left) kms_flip (2x-blocking-absolute-wf_vblank)
[211.604054] Starting subtest: 2x-blocking-absolute-wf_vblank
[211.610645] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.008s)
[211.692788] [051/131] (809s left) gem_tiled_partial_pwrite_pread (reads)
[211.747763] Subtest reads: SKIP (0.000s)
[211.808844] [052/131] (809s left) kms_psr (fbc-pr-no-drrs)
[211.879418] Starting subtest: fbc-pr-no-drrs
[211.883769] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[211.967923] [053/131] (809s left) kms_flip (plain-flip-ts-check-interruptible)
[212.046731] Starting subtest: plain-flip-ts-check-interruptible
[212.048959] Starting dynamic subtest: A-eDP1
[220.965346] Dynamic subtest A-eDP1: SUCCESS (8.884s)
[220.977821] Starting dynamic subtest: B-eDP1
[229.818549] Dynamic subtest B-eDP1: SUCCESS (8.853s)
[229.831056] Starting dynamic subtest: C-eDP1
[238.632251] Dynamic subtest C-eDP1: SUCCESS (8.800s)
[238.645238] Starting dynamic subtest: D-eDP1
[247.467063] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[247.469459] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.382s)
[248.609074] [054/131] (772s left) kms_flip (2x-flip-vs-panning-interruptible)
[248.683348] Starting subtest: 2x-flip-vs-panning-interruptible
[248.691938] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.008s)
[248.790935] [055/131] (772s left) gem_softpin (noreloc)
[248.850812] Starting subtest: noreloc
[254.284250] Subtest noreloc: SUCCESS (5.379s)
[254.353990] [056/131] (767s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[254.415051] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[254.522024] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[254.598985] [057/131] (766s left) gem_mmap_gtt (cpuset-basic-small-copy)
[254.650616] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[254.707358] [058/131] (766s left) gem_exec_schedule (u-submit-late-slice)
[254.769400] Starting subtest: u-submit-late-slice
[254.771702] Starting dynamic subtest: rcs0
[254.827550] Dynamic subtest rcs0: SUCCESS (0.063s)
[254.838743] Starting dynamic subtest: bcs0
[254.869826] Dynamic subtest bcs0: SUCCESS (0.043s)
[254.883040] Starting dynamic subtest: vcs0
[254.913530] Dynamic subtest vcs0: SUCCESS (0.043s)
[254.927296] Starting dynamic subtest: vcs1
[254.963543] Dynamic subtest vcs1: SUCCESS (0.049s)
[254.974345] Starting dynamic subtest: vecs0
[255.007481] Dynamic subtest vecs0: SUCCESS (0.043s)
[255.016867] Starting dynamic subtest: ccs0
[255.057049] Dynamic subtest ccs0: SUCCESS (0.049s)
[255.059243] Subtest u-submit-late-slice: SUCCESS (0.295s)
[256.340379] [059/131] (765s left) kms_addfb_basic (no-handle)
[256.391551] Starting subtest: no-handle
[256.393678] Subtest no-handle: SUCCESS (0.000s)
[256.512060] [060/131] (765s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[256.582413] Starting subtest: async-flip-with-page-flip-events-tiled
[256.954165] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[259.685053] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.730s)
[259.695125] Starting dynamic subtest: pipe-A-eDP-1-4
[261.870793] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[261.880836] Starting dynamic subtest: pipe-A-eDP-1-4
[263.868724] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[263.878363] Starting dynamic subtest: pipe-A-eDP-1-x
[266.047735] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[266.420834] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[269.209855] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[269.219957] Starting dynamic subtest: pipe-B-eDP-1-4
[271.394257] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[271.404666] Starting dynamic subtest: pipe-B-eDP-1-4
[273.404478] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[273.414659] Starting dynamic subtest: pipe-B-eDP-1-x
[275.583289] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[275.975172] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[278.743964] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[278.758265] Starting dynamic subtest: pipe-C-eDP-1-4
[280.918389] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[280.928833] Starting dynamic subtest: pipe-C-eDP-1-4
[282.930376] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[282.942784] Starting dynamic subtest: pipe-C-eDP-1-x
[285.096776] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[285.469801] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[288.274235] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.812s)
[288.285473] Starting dynamic subtest: pipe-D-eDP-1-4
[290.437828] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[290.448415] Starting dynamic subtest: pipe-D-eDP-1-4
[292.447736] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[292.458148] Starting dynamic subtest: pipe-D-eDP-1-x
[294.615137] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[294.617470] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.033s)
[295.769205] [061/131] (725s left) gem_ctx_isolation (nonpriv-switch)
[295.837781] Starting subtest: nonpriv-switch
[295.840250] Starting dynamic subtest: rcs0
[296.125598] Dynamic subtest rcs0: SUCCESS (0.287s)
[296.139330] Starting dynamic subtest: bcs0
[296.413344] Dynamic subtest bcs0: SUCCESS (0.287s)
[296.424085] Starting dynamic subtest: vcs0
[296.689178] Dynamic subtest vcs0: SUCCESS (0.275s)
[296.701218] Starting dynamic subtest: vcs1
[298.524554] Dynamic subtest vcs1: SUCCESS (1.834s)
[298.537112] Starting dynamic subtest: vecs0
[300.500085] Dynamic subtest vecs0: SUCCESS (1.975s)
[300.511616] Starting dynamic subtest: ccs0
[302.508637] Dynamic subtest ccs0: SUCCESS (2.007s)
[302.511089] Subtest nonpriv-switch: SUCCESS (6.671s)
[302.756880] [062/131] (719s left) api_intel_allocator (two-level-inception-interruptible)
[302.813551] Starting subtest: two-level-inception-interruptible
[308.219063] Subtest two-level-inception-interruptible: SUCCESS (5.407s)
[308.337924] [063/131] (713s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[308.437475] Starting subtest: fbcpsr-indfb-scaledprimary
[314.209431] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.776s)
[314.347812] [064/131] (707s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[314.440733] Starting subtest: x-tiled-8bpp-rotate-90
[314.461063] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[314.564134] [065/131] (707s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[314.630695] Starting subtest: fbc-psr-cursor-mmap-cpu
[314.633029] Starting dynamic subtest: eDP-1
[314.636834] Dynamic subtest eDP-1: SKIP (0.000s)
[314.641019] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[314.715168] [066/131] (707s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[314.792667] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[314.796755] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[314.874103] [067/131] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[314.958478] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[314.962944] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[315.063865] [068/131] (706s left) gem_exec_balancer (full-late-pulse)
[315.120456] Starting subtest: full-late-pulse
[320.100524] Subtest full-late-pulse: SUCCESS (4.980s)
[320.413926] [069/131] (701s left) kms_chamelium_hpd (vga-hpd-fast)
[320.782782] Subtest vga-hpd-fast: SKIP (0.000s)
[321.597702] [070/131] (700s left) prime_busy (after)
[321.655300] Starting subtest: after
[321.660469] Starting dynamic subtest: rcs0
[321.690644] Dynamic subtest rcs0: SUCCESS (0.032s)
[321.703042] Starting dynamic subtest: bcs0
[321.740267] Dynamic subtest bcs0: SUCCESS (0.048s)
[321.751644] Starting dynamic subtest: vcs0
[321.781520] Dynamic subtest vcs0: SUCCESS (0.042s)
[321.792466] Starting dynamic subtest: vcs1
[321.820779] Dynamic subtest vcs1: SUCCESS (0.038s)
[321.831881] Starting dynamic subtest: vecs0
[321.860585] Dynamic subtest vecs0: SUCCESS (0.039s)
[321.871227] Starting dynamic subtest: ccs0
[321.902507] Dynamic subtest ccs0: SUCCESS (0.041s)
[322.010783] Subtest after: SUCCESS (0.353s)
[322.084550] [071/131] (700s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[322.213042] Starting subtest: dp-mst-type-0-suspend-resume
[322.217390] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[322.346311] [072/131] (699s left) fbdev (unaligned-write)
[322.386109] Starting subtest: unaligned-write
[322.484541] Subtest unaligned-write: SUCCESS (0.100s)
[322.549596] [073/131] (699s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[322.600136] Subtest writes-after-reads: SKIP (0.000s)
[322.656101] [074/131] (699s left) kms_big_fb (linear-16bpp-rotate-270)
[322.729422] Starting subtest: linear-16bpp-rotate-270
[322.748437] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[322.866136] [075/131] (699s left) gem_userptr_blits (map-fixed-invalidate-busy)
[322.934348] Starting subtest: map-fixed-invalidate-busy
[322.938692] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[323.066076] [076/131] (699s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[323.146894] Starting subtest: fbc-rgb565-draw-mmap-cpu
[327.100150] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.956s)
[328.311293] [077/131] (694s left) gem_pxp (create-valid-protected-context)
[328.415672] Starting subtest: create-valid-protected-context
[328.418177] Subtest create-valid-protected-context: SUCCESS (0.002s)
[328.533781] [078/131] (693s left) gem_exec_schedule (u-fairslice-all)
[328.605551] Starting subtest: u-fairslice-all
[330.661289] Subtest u-fairslice-all: SUCCESS (2.059s)
[332.302744] [079/131] (690s left) gem_exec_gttfill (all-engines)
[332.360866] Starting subtest: all-engines
[357.246428] Subtest all-engines: SUCCESS (24.882s)
[357.448132] [080/131] (665s left) kms_psr (pr-sprite-plane-onoff)
[357.572267] Starting subtest: pr-sprite-plane-onoff
[357.576182] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[357.658190] [081/131] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[357.736717] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[364.988641] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.255s)
[365.113682] [082/131] (657s left) gem_userptr_blits (sync-unmap)
[365.190969] Starting subtest: sync-unmap
[365.205513] Subtest sync-unmap: SUCCESS (0.014s)
[365.350603] [083/131] (657s left) kms_psr (fbc-pr-sprite-plane-onoff)
[365.421209] Starting subtest: fbc-pr-sprite-plane-onoff
[365.425601] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[365.506885] [084/131] (657s left) device_reset (unbind-cold-reset-rebind)
[365.557269] Starting subtest: unbind-cold-reset-rebind
[365.561978] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[365.637349] [085/131] (657s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[365.710878] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[365.715257] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[365.800607] [086/131] (656s left) syncobj_eventfd (timeline-wait-before-signal)
[365.854167] Starting subtest: timeline-wait-before-signal
[365.885034] Subtest timeline-wait-before-signal: SUCCESS (0.030s)
[365.975575] [087/131] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[366.050184] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[366.053489] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[366.157892] [088/131] (656s left) gem_render_copy (y-tiled-ccs-to-linear)
[366.205121] Starting subtest: y-tiled-ccs-to-linear
[366.208390] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[366.384135] [089/131] (656s left) api_intel_bb (intel-bb-blit-x)
[366.448523] Starting subtest: intel-bb-blit-x
[369.766911] Subtest intel-bb-blit-x: SUCCESS (3.318s)
[369.892459] [090/131] (653s left) i915_drm_fdinfo (most-busy-check-all)
[369.939774] Starting subtest: most-busy-check-all
[369.942129] Starting dynamic subtest: rcs0
[369.949069] Dynamic subtest rcs0: SKIP (0.006s)
[369.960284] Starting dynamic subtest: bcs0
[369.964610] Dynamic subtest bcs0: SKIP (0.000s)
[369.975100] Starting dynamic subtest: vcs0
[369.979290] Dynamic subtest vcs0: SKIP (0.000s)
[369.989495] Starting dynamic subtest: vcs1
[369.993927] Dynamic subtest vcs1: SKIP (0.000s)
[370.004686] Starting dynamic subtest: vecs0
[370.008995] Dynamic subtest vecs0: SKIP (0.000s)
[370.019315] Starting dynamic subtest: ccs0
[370.023290] Dynamic subtest ccs0: SKIP (0.000s)
[370.027194] Subtest most-busy-check-all: SKIP (0.012s)
[370.065642] [091/131] (652s left) kms_force_connector_basic (force-edid)
[370.137768] Subtest force-edid: SKIP (0.000s)
[370.197391] [092/131] (652s left) gem_ctx_engines (execute-one)
[370.259623] Starting subtest: execute-one
[373.330200] Subtest execute-one: SUCCESS (3.071s)
[373.525850] [093/131] (649s left) gem_ctx_param (get-priority-new-ctx)
[373.586335] Starting subtest: get-priority-new-ctx
[373.588678] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[373.693132] [094/131] (649s left) kms_pipe_crc_basic (bad-source)
[373.770997] Starting subtest: bad-source
[373.772980] Subtest bad-source: SUCCESS (0.000s)
[373.841493] [095/131] (649s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[373.911126] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[373.913437] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[374.013461] [096/131] (649s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[374.084918] Starting subtest: compare-crc-sanitycheck-nv12
[374.087153] Starting dynamic subtest: pipe-A-eDP-1
[374.794627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[374.807223] Starting dynamic subtest: pipe-B-eDP-1
[376.117365] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.321s)
[376.129779] Starting dynamic subtest: pipe-C-eDP-1
[377.397865] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s)
[377.409897] Starting dynamic subtest: pipe-D-eDP-1
[378.639976] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[378.642513] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.554s)
[379.463744] [097/131] (643s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[379.516861] Starting subtest: etime-single-wait-for-submit-submitted
[379.617903] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s)
[379.707627] [098/131] (643s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[379.790543] Starting subtest: psr-rgb101010-draw-mmap-cpu
[386.830813] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.044s)
[386.934574] [099/131] (636s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[387.013787] Starting subtest: fb-8bpc-vs-panel-6bpc
[387.016092] Starting dynamic subtest: pipe-A-eDP-1
[388.479443] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.466s)
[388.481862] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.467s)
[389.345292] [100/131] (634s left) gem_exec_whisper (basic-queues-forked-all)
[389.402060] Starting subtest: basic-queues-forked-all
[407.538988] Subtest basic-queues-forked-all: SUCCESS (18.132s)
[407.721392] [101/131] (615s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[407.896245] Starting subtest: cursor-rapid-movement-128x128
[407.898457] Starting dynamic subtest: pipe-A-eDP-1
[408.477355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[408.506522] Starting dynamic subtest: pipe-D-eDP-1
[409.639370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[409.641737] Subtest cursor-rapid-movement-128x128: SUCCESS (1.744s)
[410.499884] [102/131] (612s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[410.576042] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[410.578301] Starting dynamic subtest: pipe-A-eDP-1
[410.597783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[410.609870] Starting dynamic subtest: pipe-B-eDP-1
[410.629984] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[410.640678] Starting dynamic subtest: pipe-C-eDP-1
[410.659547] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[410.671172] Starting dynamic subtest: pipe-D-eDP-1
[410.690531] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[410.692752] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[412.769216] [103/131] (610s left) kms_cursor_crc (cursor-offscreen-32x32)
[412.890593] Starting subtest: cursor-offscreen-32x32
[412.942482] Subtest cursor-offscreen-32x32: SKIP (0.046s)
[413.198854] [104/131] (610s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[413.279675] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[413.284074] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[413.369618] [105/131] (610s left) syncobj_wait (invalid-wait-illegal-handle)
[413.425524] Starting subtest: invalid-wait-illegal-handle
[413.427892] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[413.515891] [106/131] (610s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[413.574959] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[413.725748] [107/131] (609s left) gem_exec_reloc (basic-cpu-gtt-active)
[413.783619] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[413.866588] [108/131] (609s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[413.935950] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[413.939696] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[414.043599] [109/131] (609s left) gem_spin_batch (spin-all)
[414.115467] Starting subtest: spin-all
[414.128396] Subtest spin-all: SUCCESS (0.013s)
[415.274198] [110/131] (608s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[415.374978] Starting subtest: cursor-tearing-framebuffer-change
[415.376975] Starting dynamic subtest: pipe-A-eDP-1
[415.966080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[415.978996] Starting dynamic subtest: pipe-D-eDP-1
[417.214354] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s)
[417.216746] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.842s)
[418.052842] [111/131] (605s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[418.135479] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[418.140063] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[418.224367] [112/131] (605s left) gem_exec_reloc (basic-cpu-gtt)
[418.281670] Subtest basic-cpu-gtt: SKIP (0.000s)
[418.354171] [113/131] (605s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[418.441355] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[418.445755] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[418.525288] [114/131] (605s left) kms_vblank (wait-forked-hang)
[418.597905] Starting subtest: wait-forked-hang
[418.600220] Starting dynamic subtest: pipe-A-eDP-1
[445.000238] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.398s)
[445.016894] Starting dynamic subtest: pipe-D-eDP-1
[459.974763] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[459.977408] Subtest wait-forked-hang: SUCCESS (41.376s)
[460.816902] [115/131] (563s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[460.903105] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[460.905378] Starting dynamic subtest: pipe-A-eDP-1
[460.933451] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[460.945353] Starting dynamic subtest: pipe-B-eDP-1
[460.969642] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[460.980340] Starting dynamic subtest: pipe-C-eDP-1
[461.004234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[461.014495] Starting dynamic subtest: pipe-D-eDP-1
[461.038586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[461.043027] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[463.173049] [116/131] (560s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[463.259754] Starting subtest: psr-rgb565-draw-render
[470.304346] Subtest psr-rgb565-draw-render: SUCCESS (7.049s)
[470.416399] [117/131] (553s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[470.495572] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[477.184073] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.692s)
[477.301006] [118/131] (546s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[477.382813] Starting subtest: fbc-2p-pri-indfb-multidraw
[477.387082] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[477.495155] [119/131] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[477.575047] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[477.579555] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[477.655664] [120/131] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[477.742249] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[484.307212] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.569s)
[484.408336] [121/131] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[484.494136] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[488.472738] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.985s)
[489.628524] [122/131] (534s left) kms_chamelium_edid (vga-edid-read)
[490.001367] Subtest vga-edid-read: SKIP (0.000s)
[490.829508] [123/131] (533s left) kms_vrr (seamless-rr-switch-vrr)
[490.910695] Starting subtest: seamless-rr-switch-vrr
[490.917174] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[490.994471] [124/131] (533s left) gem_exec_schedule (preempt-hang)
[491.163035] Starting subtest: preempt-hang
[491.165337] Starting dynamic subtest: rcs0
[491.379378] Dynamic subtest rcs0: SUCCESS (0.217s)
[491.392381] Starting dynamic subtest: bcs0
[491.596073] Dynamic subtest bcs0: SUCCESS (0.215s)
[491.608233] Starting dynamic subtest: vcs0
[491.820320] Dynamic subtest vcs0: SUCCESS (0.224s)
[491.832121] Starting dynamic subtest: vcs1
[492.051068] Dynamic subtest vcs1: SUCCESS (0.229s)
[492.064125] Starting dynamic subtest: vecs0
[492.275511] Dynamic subtest vecs0: SUCCESS (0.224s)
[492.288150] Starting dynamic subtest: ccs0
[492.502415] Dynamic subtest ccs0: SUCCESS (0.225s)
[492.504433] Subtest preempt-hang: SUCCESS (1.341s)
[493.334139] [125/131] (531s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[493.408235] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[493.435526] Starting dynamic subtest: pipe-A-plane-0
[493.701815] Dynamic subtest pipe-A-plane-0: SUCCESS (0.266s)
[493.715627] Starting dynamic subtest: pipe-A-plane-3
[493.924139] Dynamic subtest pipe-A-plane-3: SUCCESS (0.222s)
[493.935167] Starting dynamic subtest: pipe-A-plane-5
[493.939601] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[495.037863] Starting dynamic subtest: pipe-B-plane-0
[495.304752] Dynamic subtest pipe-B-plane-0: SUCCESS (0.277s)
[495.316463] Starting dynamic subtest: pipe-B-plane-3
[495.516387] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[495.527677] Starting dynamic subtest: pipe-B-plane-5
[495.532249] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[495.834670] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.426s)
[496.713633] [126/131] (527s left) vgem_basic (setversion)
[496.763085] Starting subtest: setversion
[496.767238] Subtest setversion: SUCCESS (0.000s)
[496.819980] [127/131] (527s left) kms_psr (psr2-cursor-render)
[496.895193] Starting subtest: psr2-cursor-render
[496.897393] Starting dynamic subtest: eDP-1
[498.600138] Dynamic subtest eDP-1: SUCCESS (1.703s)
[498.602563] Subtest psr2-cursor-render: SUCCESS (1.704s)
[499.387147] [128/131] (525s left) i915_hangman (engine-error-state-capture)
[499.447852] Starting subtest: engine-error-state-capture
[499.449864] Starting dynamic subtest: rcs0
[503.196474] Dynamic subtest rcs0: SUCCESS (3.748s)
[503.212382] Starting dynamic subtest: bcs0
[509.211896] Dynamic subtest bcs0: SUCCESS (6.013s)
[509.224889] Starting dynamic subtest: vcs0
[515.163797] Dynamic subtest vcs0: SUCCESS (5.949s)
[515.177752] Starting dynamic subtest: vcs1
[521.182471] Dynamic subtest vcs1: SUCCESS (6.016s)
[521.198445] Starting dynamic subtest: vecs0
[526.171782] Dynamic subtest vecs0: SUCCESS (4.986s)
[526.185368] Starting dynamic subtest: ccs0
[532.187972] Dynamic subtest ccs0: SUCCESS (6.013s)
[532.191042] Subtest engine-error-state-capture: SUCCESS (32.739s)
[532.268886] [129/131] (492s left) kms_concurrent (multi-plane-atomic-lowres)
[532.351571] Starting subtest: multi-plane-atomic-lowres
[532.353388] Starting dynamic subtest: pipe-A-eDP-1
[532.845169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.494s)
[532.857903] Starting dynamic subtest: pipe-B-eDP-1
[534.145445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.299s)
[534.157507] Starting dynamic subtest: pipe-C-eDP-1
[535.341216] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.194s)
[535.352569] Starting dynamic subtest: pipe-D-eDP-1
[536.584611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[536.587019] Subtest multi-plane-atomic-lowres: SUCCESS (4.233s)
[537.430385] [130/131] (487s left) kms_atomic (plane-invalid-params-fence)
[537.499873] Starting subtest: plane-invalid-params-fence
[537.502271] Starting dynamic subtest: pipe-A-eDP-1
[537.854493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[537.856791] Subtest plane-invalid-params-fence: SUCCESS (0.357s)
[538.648847] [131/131] (486s left) perf_pmu (enable-race)
[538.694898] Starting subtest: enable-race
[538.697191] Starting dynamic subtest: rcs0
[551.477202] Dynamic subtest rcs0: SUCCESS (12.765s)
[551.489648] Starting dynamic subtest: bcs0
[564.218621] Dynamic subtest bcs0: SUCCESS (12.736s)
[564.232738] Starting dynamic subtest: vcs0
[580.222274] Dynamic subtest vcs0: SUCCESS (16.019s)
[580.237185] Starting dynamic subtest: vcs1
[596.221692] Dynamic subtest vcs1: SUCCESS (15.996s)
[596.235963] Starting dynamic subtest: vecs0
[612.221489] Dynamic subtest vecs0: SUCCESS (15.996s)
[612.234215] Starting dynamic subtest: ccs0
[624.983199] Dynamic subtest ccs0: SUCCESS (12.741s)
[624.985161] Subtest enable-race: SUCCESS (86.268s)
[625.071240] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_pwrite_crc
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_invalid_mode
results: parsing output: 7/ for test: kms_pm_rpm
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: drm_read
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_sequence
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_pm_lpsp
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: gem_mmap_offset
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: i915_pm_rpm
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane_multiple
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: prime_self_import
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_draw_crc
results: parsing output: 40/ for test: gem_exec_suspend
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_capture
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gen9_exec_parse
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: i915_suspend
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_ctx_isolation
results: parsing output: 61/ for test: api_intel_allocator
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: prime_busy
results: parsing output: 70/ for test: kms_content_protection
results: parsing output: 71/ for test: fbdev
results: parsing output: 72/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_pxp
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: gem_exec_gttfill
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: device_reset
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: syncobj_eventfd
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: kms_force_connector_basic
results: parsing output: 91/ for test: gem_ctx_engines
results: parsing output: 92/ for test: gem_ctx_param
results: parsing output: 93/ for test: kms_pipe_crc_basic
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_pipe_crc_basic
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_dither
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_spin_batch
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_vblank
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_chamelium_edid
results: parsing output: 122/ for test: kms_vrr
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: i915_hangman
results: parsing output: 128/ for test: kms_concurrent
results: parsing output: 129/ for test: kms_atomic
results: parsing output: 130/ for test: perf_pmu
Done.