[57.597554] Initializing watchdogs
[57.597600]   /dev/watchdog0
[57.612168] [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]
[57.616567] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.619334] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.622830] [001/156] (960s left) prime_busy (before)
[57.703090] Starting subtest: before
[57.705452] Starting dynamic subtest: rcs0
[57.739744] Dynamic subtest rcs0: SUCCESS (0.034s)
[57.749880] Starting dynamic subtest: bcs0
[57.797430] Dynamic subtest bcs0: SUCCESS (0.056s)
[57.807559] Starting dynamic subtest: vcs0
[57.839498] Dynamic subtest vcs0: SUCCESS (0.041s)
[57.848040] Starting dynamic subtest: vcs1
[57.880659] Dynamic subtest vcs1: SUCCESS (0.040s)
[57.888921] Starting dynamic subtest: vecs0
[57.923597] Dynamic subtest vecs0: SUCCESS (0.042s)
[57.932323] Starting dynamic subtest: ccs0
[57.966499] Dynamic subtest ccs0: SUCCESS (0.041s)
[58.073906] Subtest before: SUCCESS (0.363s)
[58.147775] [002/156] (960s left) vgem_basic (dmabuf-export)
[58.216606] Starting subtest: dmabuf-export
[58.253453] Subtest dmabuf-export: SUCCESS (0.037s)
[58.351998] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[58.355105] [003/156] (959s left) kms_vrr (seamless-rr-switch-virtual)
[58.470633] Starting subtest: seamless-rr-switch-virtual
[58.476850] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[58.542831] [004/156] (959s left) kms_flip (flip-vs-expired-vblank-interruptible)
[58.642110] Starting subtest: flip-vs-expired-vblank-interruptible
[58.644538] Starting dynamic subtest: A-eDP1
[67.379203] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[67.386914] Starting dynamic subtest: B-eDP1
[76.080725] Dynamic subtest B-eDP1: SUCCESS (8.671s)
[76.089932] Starting dynamic subtest: C-eDP1
[84.728433] Dynamic subtest C-eDP1: SUCCESS (8.637s)
[84.738517] Starting dynamic subtest: D-eDP1
[93.358706] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[93.363370] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.582s)
[94.536770] [005/156] (923s left) gem_exec_schedule (preempt-queue)
[94.601748] Subtest preempt-queue: SKIP (0.000s)
[94.885165] [006/156] (923s left) kms_properties (get_properties-sanity-atomic)
[94.980891] Starting subtest: get_properties-sanity-atomic
[94.983236] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[95.052303] [007/156] (923s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[95.098816] Starting subtest: mixed-tiled-to-y-tiled-ccs
[95.103393] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[95.281657] [008/156] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[95.378048] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[99.342914] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.969s)
[100.567489] [009/156] (917s left) api_intel_bb (bb-with-allocator)
[100.624677] Starting subtest: bb-with-allocator
[100.629605] Subtest bb-with-allocator: SUCCESS (0.006s)
[100.749938] [010/156] (917s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[100.846923] Starting subtest: fbc-1p-pri-indfb-multidraw
[113.877662] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.034s)
[115.289843] [011/156] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[115.394535] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[115.398617] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[115.483646] [012/156] (903s left) gem_mmap_gtt (basic-write-read)
[115.537027] Subtest basic-write-read: SKIP (0.000s)
[115.593890] [013/156] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[115.687129] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[115.691329] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[115.793349] [014/156] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[115.892452] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[122.669190] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.782s)
[122.819565] [015/156] (895s left) i915_drm_fdinfo (all-busy-check-all)
[122.855953] Starting subtest: all-busy-check-all
[122.863880] Subtest all-busy-check-all: SKIP (0.006s)
[122.922848] [016/156] (895s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[123.018892] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[123.085062] [017/156] (895s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[123.186993] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[123.191552] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[123.280146] [018/156] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[123.383590] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[123.388041] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[123.476399] [019/156] (895s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[123.587278] Starting subtest: fbc-rgb565-draw-pwrite
[128.234779] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.653s)
[129.386016] [020/156] (889s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[129.484758] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[129.489239] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[129.594502] [021/156] (889s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[129.644726] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[129.647051] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[129.749016] [022/156] (889s left) kms_color (ctm-red-to-blue)
[129.839792] Starting subtest: ctm-red-to-blue
[129.842057] Starting dynamic subtest: pipe-A-eDP-1
[130.578346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[130.586687] Starting dynamic subtest: pipe-B-eDP-1
[131.984386] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[131.992250] Starting dynamic subtest: pipe-C-eDP-1
[133.369550] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[133.381691] Starting dynamic subtest: pipe-D-eDP-1
[134.783306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.414s)
[134.785684] Subtest ctm-red-to-blue: SUCCESS (4.944s)
[135.604269] [023/156] (883s left) kms_chamelium_hpd (hdmi-hpd)
[135.981800] Subtest hdmi-hpd: SKIP (0.000s)
[136.801407] [024/156] (882s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[136.901206] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[136.903434] Starting dynamic subtest: pipe-A-eDP-1
[152.472832] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.505s)
[152.487694] Starting dynamic subtest: pipe-B-eDP-1
[169.451471] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.452s)
[169.461501] Starting dynamic subtest: pipe-C-eDP-1
[186.435183] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.349s)
[186.445628] Starting dynamic subtest: pipe-D-eDP-1
[203.416541] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.339s)
[203.418768] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.649s)
[204.616003] [025/156] (814s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[204.680405] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[204.682840] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[204.776467] [026/156] (814s left) kms_lease (possible-crtcs-filtering)
[204.864953] Starting subtest: possible-crtcs-filtering
[204.872016] Subtest possible-crtcs-filtering: SUCCESS (0.009s)
[204.981013] [027/156] (814s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render)
[205.082695] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render
[205.087271] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[205.198105] [028/156] (814s left) gem_exec_suspend (basic-s3)
[205.258576] Starting subtest: basic-S3
[205.261099] Starting dynamic subtest: smem
[225.204960] Dynamic subtest smem: SUCCESS (6.459s)
[225.208099] Subtest basic-S3: SUCCESS (6.461s)
[225.393547] [029/156] (793s left) gem_render_copy (y-tiled-ccs-to-linear)
[225.457604] Starting subtest: y-tiled-ccs-to-linear
[225.462116] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[225.641814] [030/156] (793s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[225.738502] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[225.740971] Starting dynamic subtest: pipe-A
[225.761175] Dynamic subtest pipe-A: SKIP (0.017s)
[225.771946] Starting dynamic subtest: pipe-B
[225.793729] Dynamic subtest pipe-B: SKIP (0.032s)
[225.803532] Starting dynamic subtest: pipe-C
[225.826746] Dynamic subtest pipe-C: SKIP (0.031s)
[225.836136] Starting dynamic subtest: pipe-D
[225.859130] Dynamic subtest pipe-D: SKIP (0.031s)
[225.862983] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.113s)
[225.965140] [031/156] (793s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[226.071075] Starting subtest: fbcpsrhdr-2p-rte
[226.075327] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[226.185218] [032/156] (793s left) syncobj_timeline (host-signal-points)
[226.239489] Starting subtest: host-signal-points
[226.244649] Subtest host-signal-points: SUCCESS (0.004s)
[226.345730] [033/156] (793s left) kms_psr (psr-primary-mmap-gtt)
[226.438713] Starting subtest: psr-primary-mmap-gtt
[226.440775] Starting dynamic subtest: eDP-1
[227.973750] Dynamic subtest eDP-1: SKIP (1.490s)
[227.978880] Subtest psr-primary-mmap-gtt: SKIP (1.492s)
[228.135381] [034/156] (791s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[228.236891] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[228.241476] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[228.301949] [035/156] (791s left) kms_getfb (getfb-handle-not-fb)
[228.400372] Starting subtest: getfb-handle-not-fb
[228.402758] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[228.518341] [036/156] (791s left) gem_mmap_offset (ptrace)
[228.571229] Starting subtest: ptrace
[228.573634] Starting dynamic subtest: smem0-wb
[228.587530] Dynamic subtest smem0-wb: SUCCESS (0.015s)
[228.598688] Starting dynamic subtest: smem0-wc
[228.609184] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[228.618167] Starting dynamic subtest: smem0-uc
[228.630203] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[228.632572] Subtest ptrace: SUCCESS (0.060s)
[228.758256] [037/156] (790s left) kms_feature_discovery (dp-mst)
[228.857028] Starting subtest: dp-mst
[228.861677] Subtest dp-mst: SKIP (0.000s)
[228.930982] [038/156] (790s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[229.029124] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[229.032723] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[229.139624] [039/156] (790s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[229.243301] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[229.246959] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[229.341156] [040/156] (790s left) gem_exec_balancer (parallel-keep-submit-fence)
[229.599997] Starting subtest: parallel-keep-submit-fence
[230.807149] Subtest parallel-keep-submit-fence: SUCCESS (1.185s)
[230.922685] [041/156] (788s left) gem_spin_batch (engines)
[230.993141] Starting subtest: engines
[230.995490] Starting dynamic subtest: rcs0
[234.332262] Dynamic subtest rcs0: SUCCESS (3.291s)
[234.344234] Starting dynamic subtest: bcs0
[237.670899] Dynamic subtest bcs0: SUCCESS (3.307s)
[237.682837] Starting dynamic subtest: vcs0
[241.009082] Dynamic subtest vcs0: SUCCESS (3.317s)
[241.019023] Starting dynamic subtest: vcs1
[244.347141] Dynamic subtest vcs1: SUCCESS (3.323s)
[244.357776] Starting dynamic subtest: vecs0
[247.680831] Dynamic subtest vecs0: SUCCESS (3.322s)
[247.691892] Starting dynamic subtest: ccs0
[250.916303] Dynamic subtest ccs0: SUCCESS (3.228s)
[250.918569] Subtest engines: SUCCESS (19.800s)
[251.144917] [042/156] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[251.260137] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[255.191409] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.932s)
[256.413675] [043/156] (763s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[256.516777] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[256.521265] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[256.647749] [044/156] (763s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[256.748952] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[257.528070] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[257.677127] [045/156] (762s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move)
[257.782227] Starting subtest: hdr-2p-primscrn-cur-indfb-move
[257.786249] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[257.875350] [046/156] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[257.969348] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[257.973749] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[258.067705] [047/156] (761s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[258.173833] Starting subtest: 4-tiled-16bpp-rotate-0
[259.497754] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.324s)
[259.623106] [048/156] (760s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[259.709506] Starting subtest: primary-x-tiled-reflect-x-0
[266.657424] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.950s)
[267.854250] [049/156] (752s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[267.948097] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[267.952342] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[268.036269] [050/156] (752s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[268.154164] Starting subtest: basic-flip-after-cursor-varying-size
[269.084914] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.932s)
[269.913702] [051/156] (750s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[269.961349] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[270.064836] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[270.154751] [052/156] (750s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[270.247856] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[270.251830] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[270.350836] [053/156] (749s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt)
[270.460077] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt
[270.464421] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[270.561944] [054/156] (749s left) kms_frontbuffer_tracking (psr-1p-rte)
[270.659941] Starting subtest: psr-1p-rte
[276.064815] Subtest psr-1p-rte: SUCCESS (5.410s)
[276.191833] [055/156] (744s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render)
[276.289865] Starting subtest: fbchdr-rgb565-draw-render
[276.294103] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s)
[276.386784] [056/156] (743s left) api_intel_bb (render-ccs)
[276.429853] Starting subtest: render-ccs
[276.773610] Subtest render-ccs: SUCCESS (0.344s)
[276.871171] [057/156] (743s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[276.925172] Starting subtest: invalid-single-wait-unsubmitted
[276.927687] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[277.043925] [058/156] (743s left) kms_atomic_interruptible (universal-setplane-primary)
[277.132549] Starting subtest: universal-setplane-primary
[277.134794] Starting dynamic subtest: pipe-A-eDP-1
[284.558285] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.424s)
[284.560838] Subtest universal-setplane-primary: SUCCESS (7.425s)
[285.398615] [059/156] (735s left) perf (low-oa-exponent-permissions)
[285.526977] Starting subtest: low-oa-exponent-permissions
[285.564523] Subtest low-oa-exponent-permissions: SUCCESS (0.040s)
[285.616516] [060/156] (734s left) kms_psr (pr-basic)
[285.708073] Starting subtest: pr-basic
[285.712291] Subtest pr-basic: SKIP (0.000s)
[285.783010] [061/156] (734s left) device_reset (unbind-reset-rebind)
[285.828540] Starting subtest: unbind-reset-rebind
[289.319278] Subtest unbind-reset-rebind: SUCCESS (3.485s)
[289.368001] [062/156] (731s left) kms_flip (2x-modeset-vs-vblank-race)
[289.464314] Starting subtest: 2x-modeset-vs-vblank-race
[289.475504] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[289.565299] [063/156] (731s left) kms_3d (basic)
[289.620300] Starting subtest: basic
[291.877635] Subtest basic: SUCCESS (2.256s)
[292.363078] [064/156] (728s left) kms_frontbuffer_tracking (fbchdr-indfb-scaledprimary)
[292.475361] Starting subtest: fbchdr-indfb-scaledprimary
[292.479942] Subtest fbchdr-indfb-scaledprimary: SKIP (0.000s)
[292.571708] [065/156] (728s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[292.656389] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[292.660625] Starting dynamic subtest: pipe-A-eDP-1
[292.685258] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.695804] Starting dynamic subtest: pipe-B-eDP-1
[292.719121] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[292.728427] Starting dynamic subtest: pipe-C-eDP-1
[292.753078] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[292.764893] Starting dynamic subtest: pipe-D-eDP-1
[292.789416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[292.793579] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[295.005232] [066/156] (725s left) kms_scaling_modes (scaling-mode-full-aspect)
[295.103624] Starting subtest: scaling-mode-full-aspect
[295.105987] Starting dynamic subtest: pipe-A-eDP-1
[295.201066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s)
[295.213690] Starting dynamic subtest: pipe-B-eDP-1
[296.426927] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.224s)
[296.440938] Starting dynamic subtest: pipe-C-eDP-1
[297.556580] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[297.566292] Starting dynamic subtest: pipe-D-eDP-1
[298.707016] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s)
[298.709334] Subtest scaling-mode-full-aspect: SUCCESS (3.605s)
[299.857926] [067/156] (720s left) i915_module_load (resize-bar)
[299.897818] Starting subtest: resize-bar
[299.904455] Subtest resize-bar: SKIP (0.007s)
[299.945865] [068/156] (720s left) gem_wait (busy)
[300.005196] Starting subtest: busy
[300.007626] Starting dynamic subtest: all-engines
[301.172891] Dynamic subtest all-engines: SUCCESS (1.165s)
[301.186364] Starting dynamic subtest: rcs0
[301.714084] Dynamic subtest rcs0: SUCCESS (0.540s)
[301.726951] Starting dynamic subtest: bcs0
[302.254124] Dynamic subtest bcs0: SUCCESS (0.538s)
[302.269229] Starting dynamic subtest: vcs0
[304.182298] Dynamic subtest vcs0: SUCCESS (1.925s)
[304.193278] Starting dynamic subtest: vcs1
[306.164197] Dynamic subtest vcs1: SUCCESS (1.978s)
[306.176537] Starting dynamic subtest: vecs0
[308.213414] Dynamic subtest vecs0: SUCCESS (2.045s)
[308.225866] Starting dynamic subtest: ccs0
[308.754473] Dynamic subtest ccs0: SUCCESS (0.540s)
[308.756846] Subtest busy: SUCCESS (8.747s)
[308.954564] [069/156] (711s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[309.053197] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[309.057226] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[309.150577] [070/156] (711s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[309.252107] Starting subtest: fbc-psr2-cursor-mmap-gtt
[309.254433] Starting dynamic subtest: eDP-1
[309.258808] Dynamic subtest eDP-1: SKIP (0.000s)
[309.263181] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[309.328133] [071/156] (711s left) kms_cursor_crc (cursor-offscreen-256x256)
[309.563557] Starting subtest: cursor-offscreen-256x256
[309.565794] Starting dynamic subtest: pipe-A-eDP-1
[311.512610] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s)
[311.545917] Starting dynamic subtest: pipe-D-eDP-1
[314.166233] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s)
[314.168477] Subtest cursor-offscreen-256x256: SUCCESS (4.603s)
[315.046627] [072/156] (705s left) kms_vblank (wait-forked)
[315.134374] Starting subtest: wait-forked
[315.136559] Starting dynamic subtest: pipe-A-eDP-1
[316.943611] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[316.959211] Starting dynamic subtest: pipe-D-eDP-1
[319.440357] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.488s)
[319.442661] Subtest wait-forked: SUCCESS (4.304s)
[320.312302] [073/156] (700s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[320.402729] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[320.406761] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[320.505947] [074/156] (700s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-pgflip-blt)
[320.619081] Starting subtest: hdr-2p-scndscrn-shrfb-pgflip-blt
[320.623378] Subtest hdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[320.712133] [075/156] (700s left) gem_lmem_swapping (basic)
[320.756333] Subtest basic: SKIP (0.000s)
[320.799029] [076/156] (700s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[320.887660] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[320.892130] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[320.994744] [077/156] (700s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[321.090258] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[321.094621] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[321.187561] [078/156] (700s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[321.277747] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[321.281027] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[321.374637] [079/156] (699s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt)
[321.469997] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt
[321.473393] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[321.566791] [080/156] (699s left) syncobj_timeline (wait-delayed-signal)
[321.625221] Starting subtest: wait-delayed-signal
[321.726865] Subtest wait-delayed-signal: SUCCESS (0.103s)
[321.836925] [081/156] (699s left) kms_content_protection (uevent)
[321.974519] Starting subtest: uevent
[321.979272] Subtest uevent: SKIP (0.000s)
[322.108754] [082/156] (699s left) gem_exec_params (no-bsd)
[322.160827] Starting subtest: no-bsd
[322.165655] Subtest no-bsd: SUCCESS (0.003s)
[324.281608] [083/156] (697s left) gem_exec_whisper (basic-fds-forked)
[324.352622] Starting subtest: basic-fds-forked
[349.089481] Subtest basic-fds-forked: SUCCESS (24.735s)
[349.271546] [084/156] (672s left) kms_flip (2x-busy-flip)
[349.382661] Starting subtest: 2x-busy-flip
[349.391433] Subtest 2x-busy-flip: SKIP (0.010s)
[349.483945] [085/156] (672s left) gem_exec_reloc (basic-concurrent0)
[349.541781] Subtest basic-concurrent0: SKIP (0.000s)
[349.602399] [086/156] (672s left) gem_mmap_offset (oob-read)
[349.663772] Starting subtest: oob-read
[349.666122] Subtest oob-read: SUCCESS (0.000s)
[349.769721] [087/156] (671s left) perf_pmu (gt-awake)
[349.811494] Starting subtest: gt-awake
[358.197908] Subtest gt-awake: SUCCESS (8.385s)
[358.309688] [088/156] (663s left) kms_chamelium_color (ctm-blue-to-red)
[358.415092] Subtest ctm-blue-to-red: SKIP (0.000s)
[358.463350] [089/156] (663s left) kms_pm_dc (dc5-dpms)
[359.567179] Starting subtest: dc5-dpms
[361.653772] Subtest dc5-dpms: SUCCESS (2.086s)
[361.728577] [090/156] (660s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[361.823252] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[361.827210] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[361.906798] [091/156] (659s left) gem_ccs (block-multicopy-compressed)
[361.966185] Starting subtest: block-multicopy-compressed
[361.970653] Subtest block-multicopy-compressed: SKIP (0.000s)
[362.103057] [092/156] (659s left) kms_chamelium_frames (hdmi-crc-multiple)
[362.480639] Subtest hdmi-crc-multiple: SKIP (0.000s)
[363.325135] [093/156] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[363.431823] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[363.436193] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[363.536736] [094/156] (658s left) gem_exec_fence (basic-busy-all)
[363.602755] Starting subtest: basic-busy-all
[363.689675] Subtest basic-busy-all: SUCCESS (0.088s)
[365.254883] [095/156] (656s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[365.355698] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[365.359715] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[365.442596] [096/156] (656s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[365.715782] Starting subtest: cursor-rapid-movement-512x512
[365.720308] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[365.899778] [097/156] (656s left) kms_getfb (getfb2-into-addfb2)
[365.998197] Starting subtest: getfb2-into-addfb2
[366.000522] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[366.104760] [098/156] (656s left) kms_prop_blob (invalid-set-prop)
[366.162611] Starting subtest: invalid-set-prop
[366.164891] Subtest invalid-set-prop: SUCCESS (0.000s)
[366.273267] [099/156] (655s left) kms_vblank (query-busy)
[366.365313] Starting subtest: query-busy
[366.367186] Starting dynamic subtest: pipe-A-eDP-1
[368.260709] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[368.277954] Starting dynamic subtest: pipe-D-eDP-1
[370.810053] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[370.812466] Subtest query-busy: SUCCESS (4.445s)
[371.612016] [100/156] (650s left) gem_exec_balancer (parallel-bb-first)
[371.875771] Starting subtest: parallel-bb-first
[372.813703] Subtest parallel-bb-first: SUCCESS (0.940s)
[373.227554] [101/156] (649s left) kms_psr (fbc-pr-cursor-blt)
[373.315890] Starting subtest: fbc-pr-cursor-blt
[373.320136] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[373.388506] [102/156] (648s left) syncobj_basic (bad-create-flags)
[373.450116] Starting subtest: bad-create-flags
[373.452555] Subtest bad-create-flags: SUCCESS (0.000s)
[373.559615] [103/156] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[373.656831] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[373.660907] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[373.760602] [104/156] (648s left) gem_madvise (dontneed-before-pwrite)
[373.795997] Starting subtest: dontneed-before-pwrite
[373.821412] Subtest dontneed-before-pwrite: SKIP (0.024s)
[373.892323] [105/156] (648s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[373.991866] Starting subtest: yf-tiled-16bpp-rotate-90
[373.996199] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[374.090315] [106/156] (648s left) gem_eio (wait-wedge-immediate)
[374.300100] Starting subtest: wait-wedge-immediate
[376.249604] Subtest wait-wedge-immediate: SUCCESS (1.948s)
[376.386214] [107/156] (646s left) kms_cursor_crc (cursor-sliding-max-size)
[376.710609] Starting subtest: cursor-sliding-max-size
[376.717226] Subtest cursor-sliding-max-size: SKIP (0.000s)
[376.840170] [108/156] (645s left) gem_workarounds (suspend-resume)
[376.895710] Starting subtest: suspend-resume
[392.248349] Subtest suspend-resume: SUCCESS (1.161s)
[392.382349] [109/156] (630s left) perf (invalid-oa-metric-set-id)
[392.507816] Starting subtest: invalid-oa-metric-set-id
[392.516929] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[392.568306] [110/156] (630s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[392.662903] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[392.667292] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[392.747304] [111/156] (629s left) kms_getfb (getfb-repeated-different-handles)
[392.851923] Starting subtest: getfb-repeated-different-handles
[392.854235] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[392.977206] [112/156] (629s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[393.072426] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[393.076694] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[393.150383] [113/156] (629s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[393.212788] Subtest no-spare-fences-busy: SKIP (0.000s)
[393.292083] [114/156] (629s left) gem_reg_read (timestamp-moving)
[393.355133] Starting subtest: timestamp-moving
[394.357394] Subtest timestamp-moving: SUCCESS (0.964s)
[394.439866] [115/156] (628s left) gem_render_copy (y-tiled-to-vebox-linear)
[394.499928] Starting subtest: y-tiled-to-vebox-linear
[394.504775] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[394.681923] [116/156] (628s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[394.779953] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[394.782669] Starting dynamic subtest: pipe-A
[394.800332] Dynamic subtest pipe-A: SKIP (0.016s)
[394.811135] Starting dynamic subtest: pipe-B
[394.834287] Dynamic subtest pipe-B: SKIP (0.030s)
[394.845372] Starting dynamic subtest: pipe-C
[394.865410] Dynamic subtest pipe-C: SKIP (0.030s)
[394.878282] Starting dynamic subtest: pipe-D
[394.893556] Dynamic subtest pipe-D: SKIP (0.029s)
[394.897423] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.108s)
[394.988708] [117/156] (627s left) gem_userptr_blits (dmabuf-unsync)
[395.057186] Subtest dmabuf-unsync: SKIP (0.000s)
[395.195019] [118/156] (627s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[395.291692] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[395.296208] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[395.414478] [119/156] (627s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[395.507403] Starting subtest: stress-xrgb8888-4tiled
[401.521267] Subtest stress-xrgb8888-4tiled: SUCCESS (5.886s)
[401.576402] [120/156] (621s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[401.678271] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[401.681987] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[401.778706] [121/156] (621s left) gem_exec_reloc (basic-gtt-active)
[401.827136] Subtest basic-gtt-active: SKIP (0.000s)
[401.899655] [122/156] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[402.002992] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[408.863552] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.803s)
[409.038157] [123/156] (614s left) i915_query (hwconfig_table)
[409.093216] Starting subtest: hwconfig_table
[409.397439] Subtest hwconfig_table: SUCCESS (0.001s)
[409.440549] [124/156] (613s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[409.539879] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[409.544322] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[409.643139] [125/156] (613s left) gem_ctx_persistence (processes)
[409.707562] Starting subtest: processes
[411.352526] Subtest processes: SUCCESS (1.640s)
[411.432535] [126/156] (611s left) kms_setmode (invalid-clone-single-crtc-stealing)
[411.481108] Starting subtest: invalid-clone-single-crtc-stealing
[411.487895] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[411.604492] [127/156] (611s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[411.690143] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[411.694458] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[411.778463] [128/156] (611s left) kms_flip (flip-vs-dpms-on-nop)
[411.866511] Starting subtest: flip-vs-dpms-on-nop
[411.868836] Starting dynamic subtest: A-eDP1
[413.746164] Dynamic subtest A-eDP1: SUCCESS (1.874s)
[413.756854] Starting dynamic subtest: B-eDP1
[415.577892] Dynamic subtest B-eDP1: SUCCESS (1.825s)
[415.592622] Starting dynamic subtest: C-eDP1
[417.408533] Dynamic subtest C-eDP1: SUCCESS (1.826s)
[417.421445] Starting dynamic subtest: D-eDP1
[419.260687] Dynamic subtest D-eDP1: SUCCESS (1.847s)
[419.263113] Subtest flip-vs-dpms-on-nop: SUCCESS (7.380s)
[420.465174] [129/156] (603s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[420.559250] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[420.563334] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[420.673749] [130/156] (602s left) gem_create (create-size-update)
[420.731304] Starting subtest: create-size-update
[420.733260] Subtest create-size-update: SUCCESS (0.000s)
[420.940970] [131/156] (602s left) gem_exec_schedule (semaphore-user)
[421.021700] Starting subtest: semaphore-user
[421.072786] Subtest semaphore-user: SUCCESS (0.057s)
[422.408454] [132/156] (601s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[422.511473] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[423.646680] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.135s)
[423.765051] [133/156] (599s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[423.828544] Starting subtest: wait-all-for-submit-delayed-submit
[423.931647] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[424.022564] [134/156] (599s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[424.125875] Starting subtest: y-tiled-8bpp-rotate-270
[424.130351] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[424.225739] [135/156] (599s left) kms_pm_rpm (universal-planes)
[426.555613] Starting subtest: universal-planes
[426.557895] Starting dynamic subtest: plane-35
[434.873636] Dynamic subtest plane-35: SUCCESS (8.317s)
[434.887379] Starting dynamic subtest: plane-65
[443.216129] Dynamic subtest plane-65: SUCCESS (8.336s)
[443.234985] Starting dynamic subtest: plane-95
[451.641296] Dynamic subtest plane-95: SUCCESS (8.417s)
[451.653922] Starting dynamic subtest: plane-125
[459.980385] Dynamic subtest plane-125: SUCCESS (8.333s)
[459.993065] Starting dynamic subtest: plane-135
[468.290884] Dynamic subtest plane-135: SUCCESS (8.303s)
[468.307768] Starting dynamic subtest: plane-145
[476.580425] Dynamic subtest plane-145: SUCCESS (8.283s)
[476.583086] Subtest universal-planes: SUCCESS (50.009s)
[476.985230] [136/156] (546s left) gem_lmem_swapping (parallel-random-verify-ccs)
[477.031622] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[477.093456] [137/156] (546s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[477.187313] Starting subtest: fbc-rgb565-draw-render
[481.339601] Subtest fbc-rgb565-draw-render: SUCCESS (4.157s)
[482.479453] [138/156] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[482.577945] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[482.582204] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[482.677701] [139/156] (541s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[482.773376] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[482.777961] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[482.869935] [140/156] (541s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[482.971971] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[482.976043] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[483.070654] [141/156] (540s left) gem_exec_fence (syncobj-timeline-signal)
[483.633244] Starting subtest: syncobj-timeline-signal
[483.636717] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[485.499239] [142/156] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[485.606618] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[485.610680] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[485.686738] [143/156] (538s left) gen7_exec_parse (bitmasks)
[485.743517] Subtest bitmasks: SKIP (0.000s)
[485.827184] [144/156] (538s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[485.927365] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[485.929477] Starting dynamic subtest: pipe-A-eDP-1
[485.949423] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[485.960258] Starting dynamic subtest: pipe-B-eDP-1
[485.980005] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[485.990520] Starting dynamic subtest: pipe-C-eDP-1
[486.010938] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[486.021332] Starting dynamic subtest: pipe-D-eDP-1
[486.041894] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[486.044142] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[488.331974] [145/156] (535s left) kms_dp_link_training (non-uhbr-mst)
[488.429124] Starting subtest: non-uhbr-mst
[488.437200] Subtest non-uhbr-mst: SKIP (0.000s)
[488.523812] [146/156] (535s left) syncobj_wait (wait-zero-handles)
[488.579619] Starting subtest: wait-zero-handles
[488.581534] Subtest wait-zero-handles: SUCCESS (0.000s)
[488.676838] [147/156] (535s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[488.774286] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[488.776504] Starting dynamic subtest: pipe-A-eDP-1
[488.799423] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[488.812022] Starting dynamic subtest: pipe-B-eDP-1
[488.833479] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[488.843921] Starting dynamic subtest: pipe-C-eDP-1
[488.865692] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[488.875916] Starting dynamic subtest: pipe-D-eDP-1
[488.898079] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[488.902139] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[491.088133] [148/156] (533s left) kms_psr (pr-sprite-render)
[491.176457] Starting subtest: pr-sprite-render
[491.180883] Subtest pr-sprite-render: SKIP (0.000s)
[491.249420] [149/156] (533s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[491.358179] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[491.362309] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[491.455559] [150/156] (532s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[491.567166] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[491.571214] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[491.671958] [151/156] (532s left) gem_ctx_shared (q-independent)
[491.728920] Starting subtest: Q-independent
[491.731399] Starting dynamic subtest: rcs0
[491.795659] Dynamic subtest rcs0: SUCCESS (0.066s)
[491.810009] Starting dynamic subtest: vcs0
[491.842845] Dynamic subtest vcs0: SUCCESS (0.046s)
[491.855658] Starting dynamic subtest: vcs1
[491.884896] Dynamic subtest vcs1: SUCCESS (0.042s)
[491.895571] Starting dynamic subtest: vecs0
[491.929587] Dynamic subtest vecs0: SUCCESS (0.044s)
[491.940528] Starting dynamic subtest: ccs0
[491.982720] Dynamic subtest ccs0: SUCCESS (0.053s)
[491.985066] Subtest Q-independent: SUCCESS (0.254s)
[493.498262] [152/156] (531s left) kms_flip (flip-vs-panning)
[493.582523] Starting subtest: flip-vs-panning
[493.584486] Starting dynamic subtest: A-eDP1
[502.292857] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[502.303897] Starting dynamic subtest: B-eDP1
[511.023830] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[511.036827] Starting dynamic subtest: C-eDP1
[519.766135] Dynamic subtest C-eDP1: SUCCESS (8.739s)
[519.777551] Starting dynamic subtest: D-eDP1
[528.489988] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[528.494667] Subtest flip-vs-panning: SUCCESS (34.916s)
[529.667527] [153/156] (494s left) kms_rotation_crc (primary-rotation-90)
[529.760117] Starting subtest: primary-rotation-90
[529.764594] Subtest primary-rotation-90: SKIP (0.001s)
[529.834803] [154/156] (494s left) kms_big_fb (4-tiled-addfb)
[529.929486] Starting subtest: 4-tiled-addfb
[529.931790] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[530.031750] [155/156] (494s left) gem_ctx_persistence (engines-hang)
[530.081238] Starting subtest: engines-hang
[530.083593] Starting dynamic subtest: rcs0
[530.196987] Dynamic subtest rcs0: SUCCESS (0.115s)
[530.210470] Starting dynamic subtest: bcs0
[530.295020] Dynamic subtest bcs0: SUCCESS (0.096s)
[530.308762] Starting dynamic subtest: vcs0
[530.386015] Dynamic subtest vcs0: SUCCESS (0.089s)
[530.399640] Starting dynamic subtest: vcs1
[530.508727] Dynamic subtest vcs1: SUCCESS (0.121s)
[530.522550] Starting dynamic subtest: vecs0
[530.622730] Dynamic subtest vecs0: SUCCESS (0.112s)
[530.638290] Starting dynamic subtest: ccs0
[530.714685] Dynamic subtest ccs0: SUCCESS (0.089s)
[530.716791] Subtest engines-hang: SUCCESS (0.635s)
[530.797169] [156/156] (493s left) i915_pm_rpm (sysfs-read)
[532.521638] Starting subtest: sysfs-read
[533.686318] Subtest sysfs-read: SUCCESS (1.166s)
[534.069695] Closing watchdogs
results: parsing output: 0/ for test: prime_busy
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: kms_vrr
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_properties
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_color
results: parsing output: 22/ for test: kms_chamelium_hpd
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_suspend
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_joiner
results: parsing output: 34/ for test: kms_getfb
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_feature_discovery
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_balancer
results: parsing output: 40/ for test: gem_spin_batch
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
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_big_fb
results: parsing output: 47/ for test: kms_rotation_crc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_atomic_interruptible
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: device_reset
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_3d
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_scaling_modes
results: parsing output: 66/ for test: i915_module_load
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_lmem_swapping
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_chamelium_color
results: parsing output: 88/ for test: kms_pm_dc
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: gem_ccs
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: kms_prop_blob
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: syncobj_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_madvise
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: gem_workarounds
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_getfb
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: gem_fenced_exec_thrash
results: parsing output: 113/ for test: gem_reg_read
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_pipe_stress
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: i915_query
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: kms_setmode
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_create
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: syncobj_wait
results: parsing output: 133/ for test: kms_big_fb
results: parsing output: 134/ for test: kms_pm_rpm
results: parsing output: 135/ for test: gem_lmem_swapping
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_exec_fence
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gen7_exec_parse
results: parsing output: 143/ for test: kms_ccs
results: parsing output: 144/ for test: kms_dp_link_training
results: parsing output: 145/ for test: syncobj_wait
results: parsing output: 146/ for test: kms_ccs
results: parsing output: 147/ for test: kms_psr
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_ctx_shared
results: parsing output: 151/ for test: kms_flip
results: parsing output: 152/ for test: kms_rotation_crc
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: gem_ctx_persistence
results: parsing output: 155/ for test: i915_pm_rpm
Done.