[51.061484] Initializing watchdogs
[51.061609]   /dev/watchdog0
[51.076217] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[51.080520] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.082701] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.085938] [001/156] (960s left) gem_partial_pwrite_pread (reads)
[51.180661] Subtest reads: SKIP (0.000s)
[51.260505] [002/156] (960s left) gen9_exec_parse (secure-batches)
[51.317203] Subtest secure-batches: SKIP (0.000s)
[51.393235] [003/156] (960s left) kms_big_fb (linear-64bpp-rotate-0)
[51.497807] Starting subtest: linear-64bpp-rotate-0
[53.126308] Subtest linear-64bpp-rotate-0: SUCCESS (1.627s)
[53.290734] [004/156] (958s left) kms_hdr (static-swap)
[53.393620] Starting subtest: static-swap
[53.396039] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[53.400346] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[53.409128] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[53.413158] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[53.417121] Subtest static-swap: SKIP (0.002s)
[53.463598] [005/156] (958s left) kms_flip (2x-flip-vs-dpms)
[53.563429] Starting subtest: 2x-flip-vs-dpms
[53.577648] Subtest 2x-flip-vs-dpms: SKIP (0.013s)
[53.679482] [006/156] (958s left) i915_pm_rc6_residency (rc6-fence)
[53.739158] Starting subtest: rc6-fence
[53.772410] Starting dynamic subtest: gt0
[66.153931] Dynamic subtest gt0: SUCCESS (12.318s)
[66.164932] Starting dynamic subtest: gt1
[81.216937] Dynamic subtest gt1: SUCCESS (15.047s)
[81.219775] Subtest rc6-fence: SUCCESS (27.402s)
[81.297293] [007/156] (930s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[81.412674] Starting subtest: psr-rgb565-draw-mmap-wc
[88.412464] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (7.004s)
[88.522346] [008/156] (923s left) gem_unref_active_buffers
[88.738314] [009/156] (923s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[88.831135] Starting subtest: fbc-pr-cursor-mmap-cpu
[88.835259] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[88.901567] [010/156] (923s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[88.993342] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[88.997884] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[89.080896] [011/156] (922s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-pwrite)
[89.177097] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-pwrite
[89.181217] Subtest hdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[89.263198] [012/156] (922s left) gem_exec_flush (basic-uc-pro-default)
[89.330709] Starting subtest: basic-uc-pro-default
[94.787724] Subtest basic-uc-pro-default: SUCCESS (5.456s)
[94.985979] [013/156] (917s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[95.107458] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[95.111808] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[95.194622] [014/156] (916s left) gem_exec_fence (basic-wait-all)
[95.258523] Starting subtest: basic-wait-all
[95.337630] Subtest basic-wait-all: SUCCESS (0.081s)
[97.355466] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[97.359119] [015/156] (914s left) perf (missing-sample-flags)
[97.479492] Starting subtest: missing-sample-flags
[97.481655] Subtest missing-sample-flags: SUCCESS (0.000s)
[97.522841] [016/156] (914s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[97.616341] Starting subtest: plane-lut1d-ctm3x4-lut1d
[97.799871] Starting dynamic subtest: pipe-A-plane-0
[97.941679] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[97.953221] Starting dynamic subtest: pipe-A-plane-1
[98.131560] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[98.140437] Starting dynamic subtest: pipe-A-plane-2
[98.297751] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[99.454888] Starting dynamic subtest: pipe-B-plane-0
[99.636748] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[99.649832] Starting dynamic subtest: pipe-B-plane-1
[99.825765] Dynamic subtest pipe-B-plane-1: SUCCESS (0.189s)
[99.837463] Starting dynamic subtest: pipe-B-plane-2
[99.970074] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[101.183188] Starting dynamic subtest: pipe-C-plane-0
[101.342486] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[101.351364] Starting dynamic subtest: pipe-C-plane-1
[101.510985] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[101.519567] Starting dynamic subtest: pipe-C-plane-2
[101.653629] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[102.822647] Starting dynamic subtest: pipe-D-plane-0
[102.959467] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[102.968778] Starting dynamic subtest: pipe-D-plane-1
[103.103853] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[103.112311] Starting dynamic subtest: pipe-D-plane-2
[103.248220] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[103.534493] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.917s)
[104.402178] [017/156] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[104.510830] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[104.515502] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[104.611559] [018/156] (907s left) gem_eio (kms)
[104.855595] Starting subtest: kms
[123.602301] Subtest kms: SUCCESS (18.745s)
[124.784065] [019/156] (887s left) gem_softpin (evict-active)
[124.845415] Starting subtest: evict-active
[124.849886] Subtest evict-active: SUCCESS (0.006s)
[124.976812] [020/156] (887s left) perf (mi-rpc)
[125.065836] Starting subtest: mi-rpc
[125.070915] Subtest mi-rpc: SKIP (0.000s)
[125.124505] [021/156] (887s left) kms_psr (psr2-dpms)
[125.219570] Starting subtest: psr2-dpms
[125.221933] Starting dynamic subtest: eDP-1
[128.183762] Dynamic subtest eDP-1: SUCCESS (2.964s)
[128.186080] Subtest psr2-dpms: SUCCESS (2.965s)
[129.076130] [022/156] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[129.183757] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[129.188160] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[129.277744] [023/156] (883s left) kms_plane_multiple (2x-tiling-4)
[129.371705] Starting subtest: 2x-tiling-4
[129.376683] Subtest 2x-tiling-4: SKIP (0.000s)
[129.466748] [024/156] (883s left) gem_exec_params (invalid-ring2)
[129.532564] Starting subtest: invalid-ring2
[129.535045] Subtest invalid-ring2: SUCCESS (0.000s)
[129.635449] [025/156] (882s left) gem_exec_schedule (u-fairslice-all)
[129.704416] Starting subtest: u-fairslice-all
[131.759673] Subtest u-fairslice-all: SUCCESS (2.060s)
[133.385475] [026/156] (879s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[133.481093] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[133.492976] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[133.598129] [027/156] (879s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff)
[133.704980] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff
[133.709472] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[133.813991] [028/156] (878s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[133.917194] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[133.921138] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[134.023171] [029/156] (878s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[134.143267] Starting subtest: 4-tiled-32bpp-rotate-0
[135.646445] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.504s)
[135.783296] [030/156] (876s left) perf_pmu (busy-accuracy-50)
[135.823471] Starting subtest: busy-accuracy-50
[135.825635] Starting dynamic subtest: rcs0
[137.356654] Dynamic subtest rcs0: SUCCESS (1.530s)
[137.367363] Starting dynamic subtest: bcs0
[138.899527] Dynamic subtest bcs0: SUCCESS (1.541s)
[138.910693] Starting dynamic subtest: vcs0
[140.440213] Dynamic subtest vcs0: SUCCESS (1.539s)
[140.449713] Starting dynamic subtest: vcs1
[141.983304] Dynamic subtest vcs1: SUCCESS (1.541s)
[141.995090] Starting dynamic subtest: vecs0
[143.526734] Dynamic subtest vecs0: SUCCESS (1.542s)
[143.538885] Starting dynamic subtest: ccs0
[145.074203] Dynamic subtest ccs0: SUCCESS (1.545s)
[145.076632] Subtest busy-accuracy-50: SUCCESS (9.249s)
[145.203346] [031/156] (867s left) gen7_exec_parse (basic-allocation)
[145.257777] Subtest basic-allocation: SKIP (0.000s)
[145.336200] [032/156] (867s left) prime_vgem (shrink)
[145.417507] Starting subtest: shrink
[145.432927] Subtest shrink: SUCCESS (0.016s)
[145.543669] [033/156] (867s left) syncobj_timeline (single-wait-for-submit-signaled)
[145.598619] Starting subtest: single-wait-for-submit-signaled
[145.600956] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[145.703963] [034/156] (867s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[145.764230] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[145.869043] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[145.947885] [035/156] (867s left) gem_exec_schedule (preemptive-hang)
[146.123744] Starting subtest: preemptive-hang
[146.126573] Starting dynamic subtest: rcs0
[155.437028] Dynamic subtest rcs0: SUCCESS (9.312s)
[155.449919] Starting dynamic subtest: bcs0
[164.392617] Dynamic subtest bcs0: SUCCESS (8.953s)
[164.403298] Starting dynamic subtest: vcs0
[173.415343] Dynamic subtest vcs0: SUCCESS (9.022s)
[173.431200] Starting dynamic subtest: vcs1
[182.439667] Dynamic subtest vcs1: SUCCESS (9.024s)
[182.448833] Starting dynamic subtest: vecs0
[191.394739] Dynamic subtest vecs0: SUCCESS (8.955s)
[191.408678] Starting dynamic subtest: ccs0
[200.424539] Dynamic subtest ccs0: SUCCESS (9.030s)
[200.427076] Subtest preemptive-hang: SUCCESS (54.300s)
[200.670545] [036/156] (812s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[200.736642] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[200.739176] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[200.832094] [037/156] (812s left) kms_flip (2x-blocking-wf_vblank)
[200.927098] Starting subtest: 2x-blocking-wf_vblank
[200.936100] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[201.021158] [038/156] (812s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[201.121383] Starting subtest: y-tiled-16bpp-rotate-270
[201.125698] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[201.241853] [039/156] (811s left) kms_draw_crc (draw-method-pwrite)
[201.331815] Starting subtest: draw-method-pwrite
[201.333694] Starting dynamic subtest: xrgb8888-untiled
[201.907315] Dynamic subtest xrgb8888-untiled: SUCCESS (0.577s)
[201.918877] Starting dynamic subtest: rgb565-untiled
[202.385818] Dynamic subtest rgb565-untiled: SUCCESS (0.477s)
[202.396066] Starting dynamic subtest: xrgb2101010-untiled
[202.940774] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.554s)
[202.951131] Starting dynamic subtest: xbgr16161616f-untiled
[203.729669] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.787s)
[203.741351] Starting dynamic subtest: xrgb8888-xtiled
[205.607685] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.877s)
[205.617752] Starting dynamic subtest: rgb565-xtiled
[206.729710] Dynamic subtest rgb565-xtiled: SUCCESS (1.121s)
[206.739693] Starting dynamic subtest: xrgb2101010-xtiled
[208.618865] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.888s)
[208.629252] Starting dynamic subtest: xbgr16161616f-xtiled
[212.054685] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.433s)
[212.066670] Starting dynamic subtest: xrgb8888-4tiled
[213.208653] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.155s)
[213.218117] Starting dynamic subtest: rgb565-4tiled
[213.774331] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[213.783760] Starting dynamic subtest: xrgb2101010-4tiled
[214.896853] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.122s)
[214.907112] Starting dynamic subtest: xbgr16161616f-4tiled
[218.029835] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.133s)
[218.032311] Subtest draw-method-pwrite: SUCCESS (16.700s)
[218.145623] [040/156] (795s left) gem_mmap_gtt (cpuset-big-copy-xy)
[218.204432] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[218.275660] [041/156] (794s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[218.334697] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[218.339338] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[218.530181] [042/156] (794s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[218.588918] Starting subtest: legacy-engines-hostile-preempt
[218.591325] Starting dynamic subtest: render
[218.662674] Dynamic subtest render: SUCCESS (0.073s)
[218.673338] Starting dynamic subtest: bsd1
[220.262878] Dynamic subtest bsd1: SUCCESS (1.597s)
[220.277216] Starting dynamic subtest: bsd2
[222.269292] Dynamic subtest bsd2: SUCCESS (2.002s)
[222.280486] Starting dynamic subtest: blt
[222.302315] Dynamic subtest blt: SUCCESS (0.033s)
[222.311452] Starting dynamic subtest: vebox
[224.300617] Dynamic subtest vebox: SUCCESS (1.995s)
[224.303337] Subtest legacy-engines-hostile-preempt: SUCCESS (5.711s)
[224.428685] [043/156] (788s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[224.546688] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[224.550707] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[224.622530] [044/156] (788s left) kms_psr (psr2-suspend)
[224.706140] Starting subtest: psr2-suspend
[224.708386] Starting dynamic subtest: eDP-1
[242.907899] Dynamic subtest eDP-1: SUCCESS (3.794s)
[242.910383] Subtest psr2-suspend: SUCCESS (3.795s)
[243.798127] [045/156] (769s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[243.912110] Starting subtest: fbc-modesetfrombusy
[247.791608] Subtest fbc-modesetfrombusy: SUCCESS (3.855s)
[249.042087] [046/156] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[249.137470] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[249.141880] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[249.237527] [047/156] (764s left) kms_chamelium_color (degamma)
[249.338891] Subtest degamma: SKIP (0.000s)
[249.382982] [048/156] (764s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite)
[249.482901] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite
[249.486862] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[249.568257] [049/156] (763s left) gem_reg_read (timestamp-moving)
[249.625783] Starting subtest: timestamp-moving
[250.626155] Subtest timestamp-moving: SUCCESS (0.996s)
[250.704288] [050/156] (762s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt)
[250.799780] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt
[250.803962] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[250.893773] [051/156] (762s left) core_auth (getclient-master-drop)
[250.930380] Starting subtest: getclient-master-drop
[250.945469] Subtest getclient-master-drop: SUCCESS (0.016s)
[251.035754] [052/156] (762s left) kms_vblank (wait-forked-busy)
[251.118749] Starting subtest: wait-forked-busy
[251.121014] Starting dynamic subtest: pipe-A-eDP-1
[253.001636] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[253.019541] Starting dynamic subtest: pipe-D-eDP-1
[255.545208] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s)
[255.547504] Subtest wait-forked-busy: SUCCESS (4.413s)
[256.356436] [053/156] (757s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[256.455064] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[256.459402] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[256.550058] [054/156] (757s left) kms_lease (multimaster-lease)
[256.633736] Starting subtest: multimaster-lease
[256.636195] Subtest multimaster-lease: SUCCESS (0.003s)
[256.738730] [055/156] (757s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[256.831280] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-blt
[256.835663] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[256.935677] [056/156] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[257.032201] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[264.473488] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.434s)
[264.576375] [057/156] (749s left) gem_ctx_isolation (preservation)
[264.638576] Starting subtest: preservation
[264.640852] Starting dynamic subtest: rcs0
[264.778909] Dynamic subtest rcs0: SUCCESS (0.139s)
[264.792817] Starting dynamic subtest: bcs0
[264.912516] Dynamic subtest bcs0: SUCCESS (0.133s)
[264.926048] Starting dynamic subtest: vcs0
[265.049714] Dynamic subtest vcs0: SUCCESS (0.136s)
[265.062742] Starting dynamic subtest: vcs1
[266.808541] Dynamic subtest vcs1: SUCCESS (1.755s)
[266.821599] Starting dynamic subtest: vecs0
[268.790862] Dynamic subtest vecs0: SUCCESS (1.979s)
[268.804522] Starting dynamic subtest: ccs0
[270.875891] Dynamic subtest ccs0: SUCCESS (2.082s)
[270.878429] Subtest preservation: SUCCESS (6.231s)
[271.132578] [058/156] (742s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render)
[271.241436] Starting subtest: fbchdr-rgb565-draw-render
[271.245999] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s)
[271.335384] [059/156] (742s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[271.427242] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[271.429216] Starting dynamic subtest: pipe-A-eDP-1
[272.636047] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.209s)
[272.647024] Starting dynamic subtest: pipe-B-eDP-1
[274.905578] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.267s)
[274.915909] Starting dynamic subtest: pipe-C-eDP-1
[277.258941] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.351s)
[277.269832] Starting dynamic subtest: pipe-D-eDP-1
[279.576707] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.316s)
[279.579176] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.147s)
[280.750220] [060/156] (733s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[280.845941] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[280.850412] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[280.939532] [061/156] (733s left) kms_psr (fbc-pr-suspend)
[281.031809] Starting subtest: fbc-pr-suspend
[281.035952] Subtest fbc-pr-suspend: SKIP (0.000s)
[281.107852] [062/156] (733s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[281.195034] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[281.197336] Starting dynamic subtest: pipe-A-eDP-1
[281.220609] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.233361] Starting dynamic subtest: pipe-B-eDP-1
[281.253866] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.263512] Starting dynamic subtest: pipe-C-eDP-1
[281.284294] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.294050] Starting dynamic subtest: pipe-D-eDP-1
[281.316670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.320834] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[283.517878] [063/156] (730s left) api_intel_allocator (reopen)
[283.576240] Starting subtest: reopen
[283.578454] Subtest reopen: SUCCESS (0.005s)
[283.724973] [064/156] (730s left) kms_addfb_basic (unused-modifier)
[283.778414] Starting subtest: unused-modifier
[283.780803] Subtest unused-modifier: SUCCESS (0.000s)
[283.914868] [065/156] (730s left) gem_bad_reloc (negative-reloc)
[283.969319] Subtest negative-reloc: SKIP (0.000s)
[284.040483] [066/156] (730s left) sw_sync (sync_multi_timeline_wait)
[284.078365] Starting subtest: sync_multi_timeline_wait
[284.080507] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[284.132572] [067/156] (730s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[284.223032] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[284.227254] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[284.319924] [068/156] (730s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[284.412164] Starting subtest: yf-tiled-32bpp-rotate-0
[284.416447] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[284.507348] [069/156] (729s left) kms_cursor_legacy (forked-bo)
[284.613084] Starting subtest: forked-bo
[284.615081] Starting dynamic subtest: pipe-A
[290.095396] Dynamic subtest pipe-A: SUCCESS (5.474s)
[290.110998] Starting dynamic subtest: pipe-B
[295.576369] Dynamic subtest pipe-B: SUCCESS (5.476s)
[295.590939] Starting dynamic subtest: pipe-C
[301.054351] Dynamic subtest pipe-C: SUCCESS (5.473s)
[301.075173] Starting dynamic subtest: pipe-D
[306.525413] Dynamic subtest pipe-D: SUCCESS (5.466s)
[306.543798] Starting dynamic subtest: all-pipes
[312.026991] Dynamic subtest all-pipes: SUCCESS (5.497s)
[312.029314] Subtest forked-bo: SUCCESS (27.397s)
[312.189302] [070/156] (702s left) i915_module_load (resize-bar)
[312.228554] Starting subtest: resize-bar
[312.235430] Subtest resize-bar: SKIP (0.007s)
[312.281012] [071/156] (702s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[312.673829] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[313.546894] [072/156] (700s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[313.643255] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[313.645519] Starting dynamic subtest: pipe-A-eDP-1
[313.654286] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.666149] Starting dynamic subtest: pipe-B-eDP-1
[313.675305] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.685458] Starting dynamic subtest: pipe-C-eDP-1
[313.694059] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.704158] Starting dynamic subtest: pipe-D-eDP-1
[313.712840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.717225] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[315.933215] [073/156] (698s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[316.031977] Starting subtest: psr2-overlay-plane-update-continuous-sf
[316.034400] Starting dynamic subtest: pipe-A-eDP-1
[317.144128] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.115s)
[317.161031] Starting dynamic subtest: pipe-B-eDP-1
[318.902414] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.756s)
[318.904813] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.874s)
[319.711184] [074/156] (694s left) kms_psr (psr-sprite-mmap-cpu)
[319.801516] Starting subtest: psr-sprite-mmap-cpu
[319.803837] Starting dynamic subtest: eDP-1
[321.526368] Dynamic subtest eDP-1: SUCCESS (1.723s)
[321.528639] Subtest psr-sprite-mmap-cpu: SUCCESS (1.724s)
[322.378401] [075/156] (692s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[322.505931] Starting subtest: x-tiled-16bpp-rotate-270
[322.524668] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[322.653560] [076/156] (692s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[322.764814] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[322.768926] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[322.857062] [077/156] (691s left) kms_psr (pr-cursor-mmap-gtt)
[322.950413] Starting subtest: pr-cursor-mmap-gtt
[322.954870] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[323.031617] [078/156] (691s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[323.120400] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[323.130093] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[323.237806] [079/156] (691s left) kms_vblank (query-forked-hang)
[323.334846] Starting subtest: query-forked-hang
[323.336706] Starting dynamic subtest: pipe-A-eDP-1
[349.443985] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.110s)
[349.459832] Starting dynamic subtest: pipe-D-eDP-1
[364.487222] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.044s)
[364.489303] Subtest query-forked-hang: SUCCESS (41.159s)
[365.331341] [080/156] (649s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[365.428842] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[365.431208] Starting dynamic subtest: pipe-A-eDP-1
[365.455514] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[365.466733] Starting dynamic subtest: pipe-B-eDP-1
[365.488807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[365.499335] Starting dynamic subtest: pipe-C-eDP-1
[365.521865] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[365.533575] Starting dynamic subtest: pipe-D-eDP-1
[365.556586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[365.560516] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[367.682874] [081/156] (647s left) gem_tiled_blits (normal)
[367.744416] Subtest normal: SKIP (0.000s)
[367.813328] [082/156] (647s left) drm_read (short-buffer-wakeup)
[367.974538] Starting subtest: short-buffer-wakeup
[400.188025] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[400.325592] [083/156] (614s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[400.431904] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[400.435985] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[400.542775] [084/156] (614s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[400.635912] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[400.640290] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[400.739695] [085/156] (614s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[401.292855] Starting subtest: syncobj-backward-timeline-chain-engines
[401.386421] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.094s)
[402.781421] [086/156] (612s left) sysfs_preempt_timeout (invalid)
[402.837323] Starting subtest: invalid
[402.839797] Starting dynamic subtest: vecs0
[402.842191] Dynamic subtest vecs0: SUCCESS (0.000s)
[402.854416] Starting dynamic subtest: ccs0
[402.856709] Dynamic subtest ccs0: SUCCESS (0.000s)
[402.866713] Starting dynamic subtest: vcs0
[402.869024] Dynamic subtest vcs0: SUCCESS (0.000s)
[402.878891] Starting dynamic subtest: bcs0
[402.881176] Dynamic subtest bcs0: SUCCESS (0.000s)
[402.891195] Starting dynamic subtest: rcs0
[402.893435] Dynamic subtest rcs0: SUCCESS (0.000s)
[402.903256] Starting dynamic subtest: vcs1
[402.905147] Dynamic subtest vcs1: SUCCESS (0.000s)
[402.907064] Subtest invalid: SUCCESS (0.006s)
[402.946405] [087/156] (612s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[403.038030] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[403.049067] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[403.127297] [088/156] (612s left) kms_pm_dc (dc6-psr)
[404.233129] Starting subtest: dc6-psr
[407.203878] Subtest dc6-psr: SUCCESS (2.971s)
[408.013701] [089/156] (607s left) gem_exec_fence (basic-busy)
[408.206513] Starting subtest: basic-busy
[408.208872] Starting dynamic subtest: rcs0
[408.290570] Dynamic subtest rcs0: SUCCESS (0.084s)
[408.304024] Starting dynamic subtest: bcs0
[408.343489] Dynamic subtest bcs0: SUCCESS (0.050s)
[408.355848] Starting dynamic subtest: vcs0
[408.398254] Dynamic subtest vcs0: SUCCESS (0.053s)
[408.410845] Starting dynamic subtest: vcs1
[408.451624] Dynamic subtest vcs1: SUCCESS (0.051s)
[408.464520] Starting dynamic subtest: vecs0
[408.503373] Dynamic subtest vecs0: SUCCESS (0.050s)
[408.516410] Starting dynamic subtest: ccs0
[408.555801] Dynamic subtest ccs0: SUCCESS (0.050s)
[408.558335] Subtest basic-busy: SUCCESS (0.350s)
[410.765128] [090/156] (604s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[410.827267] Starting subtest: etime-multi-wait-all-submitted-signaled
[410.931746] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[411.028840] [091/156] (604s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[411.123210] Starting subtest: primary-y-tiled-reflect-x-0
[411.184329] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[411.293238] [092/156] (604s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[411.387270] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[411.391563] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[411.495250] [093/156] (603s left) gem_readwrite (new-obj)
[411.546372] Subtest new-obj: SKIP (0.000s)
[411.604968] [094/156] (603s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[411.704395] Starting subtest: fbcpsr-stridechange
[417.931154] Subtest fbcpsr-stridechange: SUCCESS (6.229s)
[418.067607] [095/156] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[418.166320] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[418.170566] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[418.292737] [096/156] (597s left) gem_gpgpu_fill (basic)
[418.343102] Starting subtest: basic
[418.345588] Starting dynamic subtest: smem
[418.351816] Dynamic subtest smem: SUCCESS (0.009s)
[418.354020] Subtest basic: SUCCESS (0.010s)
[418.503516] [097/156] (597s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-pgflip-blt)
[418.603478] Starting subtest: fbchdr-2p-scndscrn-indfb-pgflip-blt
[418.608001] Subtest fbchdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[418.701235] [098/156] (596s left) gem_pread (display)
[418.772913] Subtest display: SKIP (0.000s)
[418.835240] [099/156] (596s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[418.932106] Starting subtest: 4-tiled-16bpp-rotate-0
[420.289624] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.356s)
[420.409390] [100/156] (595s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[420.511736] Starting subtest: fb-8bpc-vs-panel-6bpc
[420.513623] Starting dynamic subtest: pipe-A-eDP-1
[421.926737] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.415s)
[421.929044] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.416s)
[422.802115] [101/156] (592s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[422.897874] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[422.901734] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[422.966615] [102/156] (592s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[423.062312] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[423.066726] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[423.154459] [103/156] (592s left) kms_pm_rpm (modeset-stress-extra-wait)
[424.877239] Starting subtest: modeset-stress-extra-wait
[479.229254] Subtest modeset-stress-extra-wait: SUCCESS (54.342s)
[479.318928] [104/156] (536s left) gem_pxp (verify-pxp-stale-ctx-execution)
[479.434235] Starting subtest: verify-pxp-stale-ctx-execution
[480.491829] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[480.631864] [105/156] (535s left) gem_pwrite (basic-random)
[480.679043] Subtest basic-random: SKIP (0.000s)
[480.742250] [106/156] (535s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[480.789479] Starting subtest: multi-wait-all-for-submit-available-submitted
[480.791423] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[480.898809] [107/156] (535s left) kms_busy (extended-pageflip-hang-newfb)
[480.998274] Starting subtest: extended-pageflip-hang-newfb
[481.000231] Starting dynamic subtest: pipe-A
[507.493839] Dynamic subtest pipe-A: SUCCESS (26.497s)
[507.504546] Starting dynamic subtest: pipe-D
[532.508954] Dynamic subtest pipe-D: SUCCESS (25.014s)
[532.511266] Subtest extended-pageflip-hang-newfb: SUCCESS (51.515s)
[533.355424] [108/156] (482s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[533.453498] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[533.457804] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[533.536149] [109/156] (482s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[533.635356] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[540.171953] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.538s)
[540.293477] [110/156] (475s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[540.388814] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[540.391120] Starting dynamic subtest: pipe-A
[540.511209] Dynamic subtest pipe-A: SKIP (0.119s)
[540.522613] Starting dynamic subtest: pipe-B
[541.745127] Dynamic subtest pipe-B: SKIP (1.232s)
[541.756158] Starting dynamic subtest: pipe-C
[542.973851] Dynamic subtest pipe-C: SUCCESS (1.234s)
[542.985621] Starting dynamic subtest: pipe-D
[544.190362] Dynamic subtest pipe-D: SUCCESS (1.215s)
[544.192880] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.804s)
[545.377610] [111/156] (470s left) i915_drm_fdinfo (memory-info-shared)
[545.416534] Starting subtest: memory-info-shared
[545.418953] Starting dynamic subtest: smem0
[545.468604] Dynamic subtest smem0: SUCCESS (0.051s)
[545.471590] Subtest memory-info-shared: SUCCESS (0.052s)
[545.559209] [112/156] (470s left) gem_close_race (multigpu-basic-threads)
[545.616405] Starting subtest: multigpu-basic-threads
[545.620936] Subtest multigpu-basic-threads: SKIP (0.000s)
[545.839155] [113/156] (470s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[545.943637] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[545.947923] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[546.061628] [114/156] (470s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[546.159582] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[549.763109] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.610s)
[550.977473] [115/156] (465s left) vgem_basic (unload)
[551.013496] Starting subtest: unload
[580.025497] Subtest unload: SUCCESS (29.008s)
[580.126138] [116/156] (436s left) kms_cursor_crc (cursor-sliding-128x128)
[580.355148] Starting subtest: cursor-sliding-128x128
[580.357324] Starting dynamic subtest: pipe-A-eDP-1
[583.568001] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.208s)
[583.597133] Starting dynamic subtest: pipe-D-eDP-1
[587.487604] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.896s)
[587.490019] Subtest cursor-sliding-128x128: SUCCESS (7.132s)
[588.337110] [117/156] (428s left) gem_exec_schedule (implicit-read-write)
[588.406832] Starting subtest: implicit-read-write
[588.408896] Starting dynamic subtest: rcs0
[588.513059] Dynamic subtest rcs0: SUCCESS (0.116s)
[588.526750] Starting dynamic subtest: vcs0
[588.597596] Dynamic subtest vcs0: SUCCESS (0.083s)
[588.613016] Starting dynamic subtest: vcs1
[588.686677] Dynamic subtest vcs1: SUCCESS (0.087s)
[588.701434] Starting dynamic subtest: vecs0
[588.761541] Dynamic subtest vecs0: SUCCESS (0.074s)
[588.775872] Starting dynamic subtest: ccs0
[588.844592] Dynamic subtest ccs0: SUCCESS (0.083s)
[588.847108] Subtest implicit-read-write: SUCCESS (0.449s)
[589.796167] [118/156] (426s left) template (a)
[589.850848] Starting subtest: A
[589.853148] Subtest A: SUCCESS (0.000s)
[589.951598] [119/156] (426s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[590.050076] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[590.054369] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[590.155520] [120/156] (426s left) gem_exec_whisper (basic-forked)
[590.219997] Starting subtest: basic-forked
[597.655903] Subtest basic-forked: SUCCESS (7.432s)
[597.843332] [121/156] (418s left) gem_spin_batch (user-each)
[597.912836] Starting subtest: user-each
[601.283794] Subtest user-each: SUCCESS (3.370s)
[601.744879] [122/156] (414s left) syncobj_wait (single-wait-for-submit-submitted)
[601.798034] Starting subtest: single-wait-for-submit-submitted
[601.908298] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[601.987481] [123/156] (414s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[602.073949] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[602.078608] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[603.164526] [124/156] (413s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt)
[603.279628] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt
[603.283966] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[603.377944] [125/156] (413s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[603.480822] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[603.485005] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[603.572174] [126/156] (413s left) gem_exec_balancer (bonded-sync)
[603.645361] Starting subtest: bonded-sync
[603.650041] Subtest bonded-sync: SKIP (0.000s)
[603.947032] [127/156] (412s left) gem_exec_schedule (smoketest-all)
[604.026354] Starting subtest: smoketest-all
[636.393587] Subtest smoketest-all: SUCCESS (32.320s)
[637.703942] [128/156] (379s left) drm_read (invalid-buffer)
[637.857547] Starting subtest: invalid-buffer
[637.860017] Subtest invalid-buffer: SUCCESS (0.000s)
[637.984484] [129/156] (379s left) gen3_render_mixed_blits
[638.111573] [130/156] (378s left) i915_pm_sseu (full-enable)
[638.176833] Subtest full-enable: SKIP (0.000s)
[638.287352] [131/156] (378s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte)
[638.391533] Starting subtest: fbcpsrhdr-1p-rte
[638.395668] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s)
[638.487734] [132/156] (378s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-onoff)
[638.577312] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-onoff
[638.581666] Subtest fbchdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[638.661814] [133/156] (378s left) vgem_basic (mmap)
[638.710559] Starting subtest: mmap
[638.731302] Subtest mmap: SUCCESS (0.022s)
[638.791955] [134/156] (378s left) kms_content_protection (suspend-resume)
[638.929134] Starting subtest: suspend-resume
[638.932790] Subtest suspend-resume: SKIP (0.000s)
[639.054149] [135/156] (378s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[639.151440] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[646.501216] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.352s)
[647.678886] [136/156] (369s left) gem_mmap_gtt (hang-busy)
[647.739206] Subtest hang-busy: SKIP (0.000s)
[647.806140] [137/156] (369s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[647.851441] Starting subtest: multi-wait-for-submit-submitted-signaled
[647.853826] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[647.944036] [138/156] (369s left) perf_pmu (render-node-busy)
[648.013548] Starting subtest: render-node-busy
[648.016003] Starting dynamic subtest: rcs0
[648.591120] Dynamic subtest rcs0: SUCCESS (0.576s)
[648.605442] Starting dynamic subtest: bcs0
[649.152810] Dynamic subtest bcs0: SUCCESS (0.559s)
[649.166974] Starting dynamic subtest: vcs0
[650.694718] Dynamic subtest vcs0: SUCCESS (1.538s)
[650.707873] Starting dynamic subtest: vcs1
[652.680015] Dynamic subtest vcs1: SUCCESS (1.982s)
[652.693709] Starting dynamic subtest: vecs0
[654.728006] Dynamic subtest vecs0: SUCCESS (2.044s)
[654.742629] Starting dynamic subtest: ccs0
[655.295639] Dynamic subtest ccs0: SUCCESS (0.566s)
[655.298696] Subtest render-node-busy: SUCCESS (7.281s)
[655.371566] [139/156] (362s left) gem_tiled_fence_blits (normal)
[655.435542] Subtest normal: SKIP (0.000s)
[655.517694] [140/156] (361s left) gem_exec_flush (basic-wb-ro-default)
[655.585721] Starting subtest: basic-wb-ro-default
[661.043946] Subtest basic-wb-ro-default: SUCCESS (5.459s)
[661.240718] [141/156] (356s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[661.349594] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[661.353920] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[661.447083] [142/156] (356s left) kms_frontbuffer_tracking (fbc-2p-rte)
[661.553375] Starting subtest: fbc-2p-rte
[661.557847] Subtest fbc-2p-rte: SKIP (0.000s)
[661.641431] [143/156] (355s left) gem_exec_parallel (contexts)
[661.709230] Starting subtest: contexts
[661.711519] Starting dynamic subtest: rcs0
[664.782724] Dynamic subtest rcs0: SUCCESS (3.074s)
[664.797718] Starting dynamic subtest: bcs0
[668.030822] Dynamic subtest bcs0: SUCCESS (3.245s)
[668.042692] Starting dynamic subtest: vcs0
[672.114224] Dynamic subtest vcs0: SUCCESS (4.079s)
[672.125880] Starting dynamic subtest: vcs1
[676.175865] Dynamic subtest vcs1: SUCCESS (4.059s)
[676.188325] Starting dynamic subtest: vecs0
[680.174077] Dynamic subtest vecs0: SUCCESS (3.994s)
[680.185546] Starting dynamic subtest: ccs0
[683.813678] Dynamic subtest ccs0: SUCCESS (3.636s)
[683.816622] Subtest contexts: SUCCESS (22.102s)
[684.005718] [144/156] (333s left) kms_async_flips (crc-atomic)
[684.113086] Starting subtest: crc-atomic
[684.487894] Starting dynamic subtest: pipe-A-eDP-1
[687.387543] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.899s)
[687.782695] Starting dynamic subtest: pipe-B-eDP-1
[690.714841] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.947s)
[691.103296] Starting dynamic subtest: pipe-C-eDP-1
[694.039015] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.947s)
[694.411174] Starting dynamic subtest: pipe-D-eDP-1
[697.250600] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.852s)
[697.253035] Subtest crc-atomic: SUCCESS (13.136s)
[698.434793] [145/156] (319s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[698.539527] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[705.637310] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.101s)
[705.749389] [146/156] (311s left) template (b)
[705.802101] Starting subtest: B
[705.803994] Subtest B: SUCCESS (0.000s)
[705.898442] [147/156] (311s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[705.997576] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[706.001926] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[706.083391] [148/156] (311s left) gem_workarounds (reset-context)
[706.143857] Starting subtest: reset-context
[706.320155] Subtest reset-context: SUCCESS (0.176s)
[706.446899] [149/156] (311s left) vgem_basic (sysfs)
[706.493500] Starting subtest: sysfs
[706.495687] Subtest sysfs: SUCCESS (0.000s)
[706.564182] [150/156] (311s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[706.684961] Starting subtest: cursorB-vs-flipB-legacy
[706.688722] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[706.832397] [151/156] (311s left) gem_eio (in-flight-contexts-immediate)
[707.056047] Starting subtest: in-flight-contexts-immediate
[719.702041] Subtest in-flight-contexts-immediate: SUCCESS (12.642s)
[719.823135] [152/156] (298s left) kms_frontbuffer_tracking (fbc-tiling-y)
[719.926607] Starting subtest: fbc-tiling-y
[719.931118] Subtest fbc-tiling-y: SKIP (0.000s)
[720.043384] [153/156] (297s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[720.142953] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[720.145444] Starting dynamic subtest: pipe-A
[721.190531] Dynamic subtest pipe-A: SUCCESS (1.050s)
[721.202503] Starting dynamic subtest: pipe-B
[723.277038] Dynamic subtest pipe-B: SUCCESS (2.085s)
[723.288002] Starting dynamic subtest: pipe-C
[724.484520] Dynamic subtest pipe-C: SUCCESS (1.206s)
[724.501818] Starting dynamic subtest: pipe-D
[725.710015] Dynamic subtest pipe-D: SUCCESS (1.224s)
[725.712435] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.568s)
[726.902675] [154/156] (291s left) kms_cursor_crc (cursor-alpha-transparent)
[727.003865] Starting subtest: cursor-alpha-transparent
[727.006077] Starting dynamic subtest: pipe-A-eDP-1
[727.647668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s)
[727.658868] Starting dynamic subtest: pipe-D-eDP-1
[728.971870] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[728.974481] Subtest cursor-alpha-transparent: SUCCESS (1.968s)
[729.858705] [155/156] (288s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-gtt)
[729.953487] Starting subtest: hdr-rgb565-draw-mmap-gtt
[729.957569] Subtest hdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[730.053750] [156/156] (288s left) kms_plane_alpha_blend (alpha-transparent-fb)
[730.153056] Starting subtest: alpha-transparent-fb
[730.434522] Starting dynamic subtest: pipe-A-eDP-1
[731.069968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[731.081195] Starting dynamic subtest: pipe-D-eDP-1
[732.383298] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[732.385788] Subtest alpha-transparent-fb: SUCCESS (2.232s)
[733.214856] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: gen9_exec_parse
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_hdr
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: i915_pm_rc6_residency
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_unref_active_buffers
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: gem_softpin
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_multiple
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: gen7_exec_parse
results: parsing output: 31/ for test: prime_vgem
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_draw_crc
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_reg_read
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: core_auth
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_isolation
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: api_intel_allocator
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gem_bad_reloc
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: i915_module_load
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_tiled_blits
results: parsing output: 81/ for test: drm_read
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: sysfs_preempt_timeout
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_pm_dc
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_rotation_crc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_readwrite
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_gpgpu_fill
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_pread
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_dither
results: parsing output: 100/ for test: kms_joiner
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: gem_pxp
results: parsing output: 104/ for test: gem_pwrite
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_busy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: i915_drm_fdinfo
results: parsing output: 111/ for test: gem_close_race
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: vgem_basic
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: template
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: gem_spin_batch
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: drm_read
results: parsing output: 128/ for test: gen3_render_mixed_blits
results: parsing output: 129/ for test: i915_pm_sseu
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: vgem_basic
results: parsing output: 133/ for test: kms_content_protection
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_mmap_gtt
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: perf_pmu
results: parsing output: 138/ for test: gem_tiled_fence_blits
results: parsing output: 139/ for test: gem_exec_flush
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_exec_parallel
results: parsing output: 143/ for test: kms_async_flips
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: template
results: parsing output: 146/ for test: kms_flip_scaled_crc
results: parsing output: 147/ for test: gem_workarounds
results: parsing output: 148/ for test: vgem_basic
results: parsing output: 149/ for test: kms_cursor_legacy
results: parsing output: 150/ for test: gem_eio
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_plane_scaling
results: parsing output: 153/ for test: kms_cursor_crc
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_plane_alpha_blend
Done.