[65.893221] Initializing watchdogs
[65.893287]   /dev/watchdog0
[65.914659] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.925745] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.930176] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.932989] [001/156] (960s left) syncobj_timeline (multi-wait-all-available-signaled)
[66.008512] Starting subtest: multi-wait-all-available-signaled
[66.009547] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[66.171059] [002/156] (960s left) gem_eio (create-ext)
[66.442034] Starting subtest: create-ext
[66.880560] Subtest create-ext: SUCCESS (0.440s)
[68.486375] [003/156] (958s left) i915_hangman (engine-error-state-capture)
[68.607943] Starting subtest: engine-error-state-capture
[68.608975] Starting dynamic subtest: rcs0
[70.555373] Dynamic subtest rcs0: SUCCESS (1.952s)
[70.564398] Starting dynamic subtest: bcs0
[74.509403] Dynamic subtest bcs0: SUCCESS (3.960s)
[74.518126] Starting dynamic subtest: vcs0
[78.558714] Dynamic subtest vcs0: SUCCESS (4.053s)
[78.568291] Starting dynamic subtest: vcs1
[82.583376] Dynamic subtest vcs1: SUCCESS (4.024s)
[82.592781] Starting dynamic subtest: vecs0
[86.553441] Dynamic subtest vecs0: SUCCESS (3.968s)
[86.562581] Starting dynamic subtest: vecs1
[90.571294] Dynamic subtest vecs1: SUCCESS (4.017s)
[90.579864] Starting dynamic subtest: ccs0
[94.573575] Dynamic subtest ccs0: SUCCESS (4.001s)
[94.574552] Subtest engine-error-state-capture: SUCCESS (25.976s)
[94.713348] [004/156] (931s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[96.229010] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[96.230968] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[96.422428] [005/156] (930s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[97.950893] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[97.952673] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.098909] [006/156] (928s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[99.634292] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[99.635239] Starting dynamic subtest: pipe-A-HDMI-A-3
[99.644175] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[99.653136] Starting dynamic subtest: pipe-B-HDMI-A-3
[99.662287] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[99.671604] Starting dynamic subtest: pipe-C-HDMI-A-3
[99.679955] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[99.688874] Starting dynamic subtest: pipe-D-HDMI-A-3
[99.699083] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[99.700972] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[99.962025] [007/156] (926s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[101.481783] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[101.483441] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[101.616794] [008/156] (925s left) gem_tiled_partial_pwrite_pread (writes)
[101.726193] Subtest writes: SKIP (0.000s)
[101.827902] [009/156] (925s left) gem_lmem_swapping (heavy-multi)
[106.341563] Starting subtest: heavy-multi
[106.342526] Starting dynamic subtest: lmem0
[110.778853] Dynamic subtest lmem0: SUCCESS (4.437s)
[110.779722] Subtest heavy-multi: SUCCESS (4.437s)
[112.274515] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[112.276575] [010/156] (914s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[117.285138] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[117.286954] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[117.538481] [FACT kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[117.541716] [011/156] (909s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[119.057122] Starting subtest: psr-shrfb-scaledprimary
[119.058830] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[119.210782] [012/156] (908s left) kms_flip (2x-plain-flip-ts-check)
[120.762936] Starting subtest: 2x-plain-flip-ts-check
[120.776030] Subtest 2x-plain-flip-ts-check: SKIP (0.013s)
[120.883083] [013/156] (906s left) prime_vgem (basic-gtt)
[121.038813] Starting subtest: basic-gtt
[121.040789] Subtest basic-gtt: SKIP (0.000s)
[121.203235] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[121.204926] [014/156] (906s left) gem_exec_whisper (basic-queues-all)
[121.300566] Starting subtest: basic-queues-all
[143.115017] Subtest basic-queues-all: SUCCESS (21.811s)
[143.349602] [015/156] (884s left) syncobj_eventfd (timeline-wait-signaled)
[143.428241] Starting subtest: timeline-wait-signaled
[143.429187] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[143.580738] [016/156] (884s left) gem_reg_read (timestamp-monotonic)
[143.661975] Starting subtest: timestamp-monotonic
[148.256362] Subtest timestamp-monotonic: SUCCESS (4.594s)
[148.346045] [017/156] (879s left) kms_chamelium_frames (dp-crc-single)
[149.906386] Subtest dp-crc-single: SKIP (0.000s)
[150.034631] [018/156] (877s left) gem_exec_flush (basic-wb-prw-default)
[150.136449] Subtest basic-wb-prw-default: SKIP (0.000s)
[150.202166] [019/156] (877s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[151.724870] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[151.726453] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[151.870482] [020/156] (875s left) gem_exec_fence (submit3)
[152.119793] Starting subtest: submit3
[152.122365] Subtest submit3: SKIP (0.000s)
[152.842079] [021/156] (875s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[154.361053] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[154.362813] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[154.508376] [022/156] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[156.060198] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[156.062045] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[156.196466] [023/156] (871s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[157.746845] Starting subtest: fbcpsr-stridechange
[157.748467] Subtest fbcpsr-stridechange: SKIP (0.000s)
[157.879997] [024/156] (870s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[159.426903] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[159.428580] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[159.569228] [025/156] (868s left) prime_mmap (test_userptr)
[159.681780] Starting subtest: test_userptr
[159.682685] Starting dynamic subtest: test_userptr-smem
[159.683584] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[159.684485] Subtest test_userptr: SUCCESS (0.001s)
[159.854604] [026/156] (868s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[161.368296] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[195.501408] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (34.131s)
[195.709027] [027/156] (832s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[197.225189] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[197.226146] Starting dynamic subtest: pipe-A-HDMI-A-3
[197.248399] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[197.257966] Starting dynamic subtest: pipe-B-HDMI-A-3
[197.281240] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[197.290425] Starting dynamic subtest: pipe-C-HDMI-A-3
[197.316551] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[197.326194] Starting dynamic subtest: pipe-D-HDMI-A-3
[197.350170] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[197.352138] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.012s)
[197.543023] [028/156] (830s left) gen9_exec_parse (basic-rejected-ctx-param)
[197.631137] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[197.701715] [029/156] (830s left) kms_psr (fbc-psr2-no-drrs)
[199.220137] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[199.284041] [030/156] (829s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[200.805253] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[200.807010] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[200.960895] [031/156] (827s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt)
[202.509947] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt
[202.511739] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[202.651223] [032/156] (826s left) api_intel_bb (simple-bb-ctx)
[202.757188] Starting subtest: simple-bb-ctx
[202.792214] Subtest simple-bb-ctx: SUCCESS (0.035s)
[203.000856] [033/156] (825s left) kms_chamelium_audio (dp-audio-edid)
[204.564407] Subtest dp-audio-edid: SKIP (0.000s)
[204.698297] [034/156] (824s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[206.235905] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[208.482240] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.249s)
[208.719597] [035/156] (820s left) template (b)
[208.802113] Starting subtest: B
[208.803156] Subtest B: SUCCESS (0.000s)
[208.957172] [036/156] (820s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[210.478153] Starting subtest: cursorA-vs-flipA-varying-size
[221.405119] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.926s)
[221.620615] [037/156] (807s left) kms_chamelium_hpd (common-hpd-after-suspend)
[223.179157] Subtest common-hpd-after-suspend: SKIP (0.000s)
[223.309468] [038/156] (805s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[224.850423] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[224.852163] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[225.086506] [039/156] (804s left) kms_vblank (wait-busy)
[226.606300] Starting subtest: wait-busy
[226.607263] Starting dynamic subtest: pipe-A-HDMI-A-3
[229.071141] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.463s)
[229.082824] Starting dynamic subtest: pipe-D-HDMI-A-3
[231.457130] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.383s)
[231.458075] Subtest wait-busy: SUCCESS (4.850s)
[231.628498] [040/156] (797s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt)
[233.154341] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt
[233.156126] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[233.346937] [041/156] (796s left) gem_media_vme
[233.548618] [042/156] (796s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[235.062447] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[235.063304] Starting dynamic subtest: pipe-A-HDMI-A-3
[235.066973] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[235.076763] Starting dynamic subtest: pipe-B-HDMI-A-3
[235.080228] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[235.089931] Starting dynamic subtest: pipe-C-HDMI-A-3
[235.093864] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[235.103362] Starting dynamic subtest: pipe-D-HDMI-A-3
[235.106999] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[235.108813] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[235.467673] [043/156] (794s left) kms_debugfs (display-off-read-all)
[236.984748] Starting subtest: display-off-read-all
[237.037365] Subtest display-off-read-all: SUCCESS (0.054s)
[237.235634] [044/156] (792s left) kms_flip (flip-vs-modeset-vs-hang)
[238.750449] Starting subtest: flip-vs-modeset-vs-hang
[238.752557] Starting dynamic subtest: A-HDMI-A3
[289.451532] Dynamic subtest A-HDMI-A3: SUCCESS (50.698s)
[289.461809] Starting dynamic subtest: D-HDMI-A3
[339.509535] Dynamic subtest D-HDMI-A3: SUCCESS (50.056s)
[339.510450] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.758s)
[339.729687] [045/156] (690s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[341.247695] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[341.249456] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[341.341392] [046/156] (688s left) prime_mmap (test_forked)
[341.442200] Starting subtest: test_forked
[341.443137] Starting dynamic subtest: test_forked-smem
[341.501313] Dynamic subtest test_forked-smem: SUCCESS (0.060s)
[341.511182] Starting dynamic subtest: test_forked-lmem0
[341.708972] Dynamic subtest test_forked-lmem0: SUCCESS (0.207s)
[341.709993] Subtest test_forked: SUCCESS (0.268s)
[341.846627] [047/156] (688s left) kms_cursor_crc (cursor-sliding-max-size)
[343.705969] Starting subtest: cursor-sliding-max-size
[343.708605] Subtest cursor-sliding-max-size: SKIP (0.000s)
[343.892180] [048/156] (686s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[345.413637] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[345.415381] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[345.541700] [049/156] (684s left) i915_pm_rpm (system-suspend-devices)
[350.026123] Starting subtest: system-suspend-devices
[358.442718] Subtest system-suspend-devices: SUCCESS (8.420s)
[368.398582] [050/156] (670s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[369.920294] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[369.922016] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[370.063309] [051/156] (669s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[371.612010] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[371.613921] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[371.778279] [052/156] (667s left) kms_joiner (basic-force-ultra-joiner)
[373.317215] Starting subtest: basic-force-ultra-joiner
[373.318935] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[373.433112] [053/156] (666s left) gem_exec_schedule (out-order)
[373.553476] Starting subtest: out-order
[373.554397] Starting dynamic subtest: rcs0
[373.843121] Dynamic subtest rcs0: SUCCESS (0.289s)
[373.854478] Starting dynamic subtest: bcs0
[374.043736] Dynamic subtest bcs0: SUCCESS (0.200s)
[374.055201] Starting dynamic subtest: vcs0
[374.259922] Dynamic subtest vcs0: SUCCESS (0.215s)
[374.271170] Starting dynamic subtest: vcs1
[374.479630] Dynamic subtest vcs1: SUCCESS (0.219s)
[374.490648] Starting dynamic subtest: vecs0
[374.694161] Dynamic subtest vecs0: SUCCESS (0.214s)
[374.705405] Starting dynamic subtest: vecs1
[374.909981] Dynamic subtest vecs1: SUCCESS (0.215s)
[374.921901] Starting dynamic subtest: ccs0
[375.142059] Dynamic subtest ccs0: SUCCESS (0.231s)
[375.143183] Subtest out-order: SUCCESS (1.589s)
[375.573818] [054/156] (663s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[377.092549] Starting subtest: cursor-vs-flip-atomic-transitions
[408.625292] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (31.531s)
[408.810045] [055/156] (630s left) i915_query (query-topology-garbage-items)
[408.890288] Starting subtest: query-topology-garbage-items
[408.891216] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[409.095355] [056/156] (630s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[410.617489] Starting subtest: fbchdr-farfromfence-mmap-gtt
[410.619254] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[410.770606] [057/156] (628s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[412.331116] Starting subtest: 4-tiled-64bpp-rotate-180
[414.288203] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.956s)
[414.483128] [058/156] (625s left) syncobj_wait (reset-signaled)
[414.562274] Starting subtest: reset-signaled
[414.563210] Subtest reset-signaled: SUCCESS (0.000s)
[414.723207] [059/156] (625s left) syncobj_timeline (signal-point-0)
[414.805275] Starting subtest: signal-point-0
[414.806203] Subtest signal-point-0: SUCCESS (0.000s)
[414.905728] [060/156] (625s left) gem_exec_balancer (parallel-keep-submit-fence)
[415.267866] Starting subtest: parallel-keep-submit-fence
[417.665948] Subtest parallel-keep-submit-fence: SUCCESS (2.398s)
[417.795118] [061/156] (622s left) kms_plane_lowres (tiling-yf)
[419.311628] Starting subtest: tiling-yf
[419.313397] Subtest tiling-yf: SKIP (0.000s)
[419.409226] [062/156] (620s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[419.511462] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[419.513634] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[419.808381] [063/156] (620s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[421.333070] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[421.334939] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[421.497469] [064/156] (618s left) gem_exec_reloc (basic-gtt-active)
[421.605284] Subtest basic-gtt-active: SKIP (0.000s)
[421.686160] [065/156] (618s left) gem_userptr_blits (sync-unmap-after-close)
[421.802131] Starting subtest: sync-unmap-after-close
[421.824494] Subtest sync-unmap-after-close: SUCCESS (0.023s)
[422.008361] [066/156] (618s left) kms_getfb (getfb2-handle-closed)
[423.525537] Starting subtest: getfb2-handle-closed
[423.526419] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[423.683179] [067/156] (616s left) kms_prop_blob (blob-prop-validate)
[423.786373] Starting subtest: blob-prop-validate
[423.787360] Subtest blob-prop-validate: SUCCESS (0.000s)
[423.990690] [068/156] (616s left) kms_color_pipeline (plane-ctm3x4)
[425.510734] Starting subtest: plane-ctm3x4
[425.721886] Starting dynamic subtest: pipe-A-plane-0
[425.955287] Dynamic subtest pipe-A-plane-0: SUCCESS (0.233s)
[425.996403] Starting dynamic subtest: pipe-A-plane-1
[426.138541] Dynamic subtest pipe-A-plane-1: SUCCESS (0.178s)
[426.178134] Starting dynamic subtest: pipe-A-plane-2
[426.321675] Dynamic subtest pipe-A-plane-2: SUCCESS (0.180s)
[426.656191] Starting dynamic subtest: pipe-B-plane-0
[426.802581] Dynamic subtest pipe-B-plane-0: SUCCESS (0.182s)
[426.841340] Starting dynamic subtest: pipe-B-plane-1
[426.969314] Dynamic subtest pipe-B-plane-1: SUCCESS (0.163s)
[426.989105] Starting dynamic subtest: pipe-B-plane-2
[427.120042] Dynamic subtest pipe-B-plane-2: SUCCESS (0.147s)
[427.472137] Starting dynamic subtest: pipe-C-plane-0
[427.619189] Dynamic subtest pipe-C-plane-0: SUCCESS (0.182s)
[427.657532] Starting dynamic subtest: pipe-C-plane-1
[427.802509] Dynamic subtest pipe-C-plane-1: SUCCESS (0.180s)
[427.822266] Starting dynamic subtest: pipe-C-plane-2
[427.984361] Dynamic subtest pipe-C-plane-2: SUCCESS (0.180s)
[428.294061] Starting dynamic subtest: pipe-D-plane-0
[428.429202] Dynamic subtest pipe-D-plane-0: SUCCESS (0.165s)
[428.463948] Starting dynamic subtest: pipe-D-plane-1
[428.627638] Dynamic subtest pipe-D-plane-1: SUCCESS (0.195s)
[428.666660] Starting dynamic subtest: pipe-D-plane-2
[428.825600] Dynamic subtest pipe-D-plane-2: SUCCESS (0.196s)
[428.866301] Subtest plane-ctm3x4: SUCCESS (3.355s)
[429.144026] [069/156] (611s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[430.665818] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[430.667490] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[430.789807] [070/156] (609s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[432.336830] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[432.338502] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[432.487542] [071/156] (608s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[434.032879] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[434.033748] Starting dynamic subtest: pipe-A-valid-mode
[435.631535] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.598s)
[435.632455] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SUCCESS (1.600s)
[435.877291] [072/156] (605s left) syncobj_timeline (etime-multi-wait-submitted)
[435.964372] Starting subtest: etime-multi-wait-submitted
[436.067052] Subtest etime-multi-wait-submitted: SUCCESS (0.102s)
[436.187249] [073/156] (604s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[437.708946] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[437.710783] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[437.892225] [074/156] (603s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[439.428087] Starting subtest: fbchdr-rgb565-draw-pwrite
[439.429914] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[439.558080] [075/156] (601s left) kms_pm_rpm (basic-rte)
[439.630989] Starting subtest: basic-rte
[445.290750] Subtest basic-rte: SUCCESS (5.660s)
[447.277519] [076/156] (593s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[448.805928] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[448.807925] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[448.969842] [077/156] (592s left) kms_content_protection (legacy)
[450.571536] Starting subtest: legacy
[450.575478] Subtest legacy: SKIP (0.002s)
[450.749847] [078/156] (590s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[450.830464] Starting subtest: single-wait-all-for-submit-available-submitted
[450.831400] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[450.982348] [079/156] (590s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[452.501333] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[452.555302] [080/156] (588s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[454.077129] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[454.078856] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[454.228095] [081/156] (587s left) gem_ctx_param (invalid-get-no-zeromap)
[454.335773] Starting subtest: invalid-get-no-zeromap
[454.338128] Subtest invalid-get-no-zeromap: SUCCESS (0.002s)
[454.492317] [082/156] (587s left) syncobj_wait (invalid-reset-illegal-handle)
[454.572471] Starting subtest: invalid-reset-illegal-handle
[454.573433] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[454.735157] [083/156] (587s left) gem_request_retire (retire-vma-not-inactive)
[454.822717] Starting subtest: retire-vma-not-inactive
[454.904762] Subtest retire-vma-not-inactive: SUCCESS (0.082s)
[455.059407] [084/156] (586s left) gem_ctx_engines (independent)
[455.152435] Starting subtest: independent
[455.153293] Starting dynamic subtest: rcs0
[455.326184] Dynamic subtest rcs0: SUCCESS (0.163s)
[455.337541] Starting dynamic subtest: bcs0
[455.484571] Dynamic subtest bcs0: SUCCESS (0.161s)
[455.496353] Starting dynamic subtest: vcs0
[455.660393] Dynamic subtest vcs0: SUCCESS (0.173s)
[455.671877] Starting dynamic subtest: vcs1
[455.828726] Dynamic subtest vcs1: SUCCESS (0.171s)
[455.840549] Starting dynamic subtest: vecs0
[455.992832] Dynamic subtest vecs0: SUCCESS (0.167s)
[456.005278] Starting dynamic subtest: vecs1
[456.164425] Dynamic subtest vecs1: SUCCESS (0.171s)
[456.176380] Starting dynamic subtest: ccs0
[456.342805] Dynamic subtest ccs0: SUCCESS (0.177s)
[456.355159] Starting dynamic subtest: all-engines
[456.761009] Dynamic subtest all-engines: SUCCESS (0.417s)
[456.761981] Subtest independent: SUCCESS (1.609s)
[457.848749] [085/156] (584s left) syncobj_wait (wait-for-submit-snapshot)
[457.931403] Starting subtest: wait-for-submit-snapshot
[458.015069] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[458.193685] [086/156] (583s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[459.716728] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[459.718399] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[459.859917] [087/156] (582s left) kms_plane_scaling (planes-upscale-factor-0-25)
[461.405150] Starting subtest: planes-upscale-factor-0-25
[461.406125] Starting dynamic subtest: pipe-A
[461.509713] Dynamic subtest pipe-A: SUCCESS (0.105s)
[461.531407] Starting dynamic subtest: pipe-B
[461.707526] Dynamic subtest pipe-B: SUCCESS (0.196s)
[461.734069] Starting dynamic subtest: pipe-C
[461.865302] Dynamic subtest pipe-C: SUCCESS (0.156s)
[461.877149] Starting dynamic subtest: pipe-D
[462.023913] Dynamic subtest pipe-D: SUCCESS (0.158s)
[462.024920] Subtest planes-upscale-factor-0-25: SUCCESS (0.620s)
[462.245505] [088/156] (579s left) gem_tiled_pread_basic (basic)
[462.328152] Subtest basic: SKIP (0.000s)
[462.396477] [089/156] (579s left) kms_plane_alpha_blend (alpha-opaque-fb)
[463.911571] Starting subtest: alpha-opaque-fb
[464.165925] Starting dynamic subtest: pipe-A-HDMI-A-3
[464.655413] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.489s)
[464.666907] Starting dynamic subtest: pipe-D-HDMI-A-3
[465.142725] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.485s)
[465.143586] Subtest alpha-opaque-fb: SUCCESS (1.231s)
[465.379462] [090/156] (576s left) gem_exec_balancer (full-late)
[465.469858] Starting subtest: full-late
[467.485344] Subtest full-late: SUCCESS (2.015s)
[467.890805] [091/156] (574s left) kms_psr2_su (page_flip-xrgb8888)
[467.972158] Subtest page_flip-XRGB8888: SKIP (0.000s)
[468.052547] [092/156] (574s left) gem_fence_thrash (bo-copy)
[468.100336] Starting subtest: bo-copy
[468.132135] Subtest bo-copy: SKIP (0.031s)
[468.201378] [093/156] (574s left) kms_psr (fbc-psr-primary-mmap-cpu)
[469.717355] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[469.784109] [094/156] (572s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[471.310991] Starting subtest: x-tiled-32bpp-rotate-270
[471.371262] Subtest x-tiled-32bpp-rotate-270: SKIP (0.059s)
[471.563860] [095/156] (571s left) kms_sequence (get-forked)
[473.087193] Starting subtest: get-forked
[473.088193] Starting dynamic subtest: pipe-A-HDMI-A-3
[475.508458] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.421s)
[475.522946] Starting dynamic subtest: pipe-B-HDMI-A-3
[477.802596] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.292s)
[477.815838] Starting dynamic subtest: pipe-C-HDMI-A-3
[480.099747] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.296s)
[480.114189] Starting dynamic subtest: pipe-D-HDMI-A-3
[482.402794] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.300s)
[482.403724] Subtest get-forked: SUCCESS (9.316s)
[482.652261] [096/156] (560s left) gem_barrier_race (remote-request)
[482.743187] Starting subtest: remote-request
[482.744153] Starting dynamic subtest: rcs0
[488.034603] Dynamic subtest rcs0: SUCCESS (5.291s)
[488.037393] Subtest remote-request: SUCCESS (5.292s)
[488.294852] [097/156] (554s left) kms_properties (get_properties-sanity-atomic)
[489.818265] Starting subtest: get_properties-sanity-atomic
[489.820766] Subtest get_properties-sanity-atomic: SUCCESS (0.004s)
[489.923646] [098/156] (553s left) api_intel_bb (blit-noreloc-purge-cache)
[490.007519] Starting subtest: blit-noreloc-purge-cache
[490.042397] Subtest blit-noreloc-purge-cache: SUCCESS (0.035s)
[490.208281] [099/156] (552s left) perf_pmu (init-wait)
[490.282729] Starting subtest: init-wait
[490.283608] Starting dynamic subtest: rcs0
[490.286213] Dynamic subtest rcs0: SUCCESS (0.004s)
[490.300962] Starting dynamic subtest: bcs0
[490.301945] Dynamic subtest bcs0: SUCCESS (0.000s)
[490.315090] Starting dynamic subtest: vcs0
[490.316056] Dynamic subtest vcs0: SUCCESS (0.001s)
[490.328708] Starting dynamic subtest: vcs1
[490.329902] Dynamic subtest vcs1: SUCCESS (0.001s)
[490.342117] Starting dynamic subtest: vecs0
[490.343202] Dynamic subtest vecs0: SUCCESS (0.000s)
[490.355993] Starting dynamic subtest: vecs1
[490.357233] Dynamic subtest vecs1: SUCCESS (0.001s)
[490.369702] Starting dynamic subtest: ccs0
[490.370762] Dynamic subtest ccs0: SUCCESS (0.000s)
[490.371789] Subtest init-wait: SUCCESS (0.014s)
[490.435246] [100/156] (552s left) sysfs_preempt_timeout (idempotent)
[490.522229] Starting subtest: idempotent
[490.523185] Starting dynamic subtest: vecs0
[490.524138] Dynamic subtest vecs0: SUCCESS (0.001s)
[490.537501] Starting dynamic subtest: ccs0
[490.538479] Dynamic subtest ccs0: SUCCESS (0.001s)
[490.550575] Starting dynamic subtest: vcs0
[490.551491] Dynamic subtest vcs0: SUCCESS (0.001s)
[490.563803] Starting dynamic subtest: bcs0
[490.565022] Dynamic subtest bcs0: SUCCESS (0.001s)
[490.577803] Starting dynamic subtest: vecs1
[490.578998] Dynamic subtest vecs1: SUCCESS (0.001s)
[490.592352] Starting dynamic subtest: rcs0
[490.593629] Dynamic subtest rcs0: SUCCESS (0.001s)
[490.605796] Starting dynamic subtest: vcs1
[490.607008] Dynamic subtest vcs1: SUCCESS (0.001s)
[490.608206] Subtest idempotent: SUCCESS (0.013s)
[490.657720] [101/156] (552s left) prime_busy (hang)
[490.746110] Starting subtest: hang
[490.748433] Starting dynamic subtest: rcs0
[516.454228] Dynamic subtest rcs0: SUCCESS (25.705s)
[516.467096] Starting dynamic subtest: bcs0
[523.608063] Dynamic subtest bcs0: SUCCESS (7.152s)
[523.620857] Starting dynamic subtest: vcs0
[530.655489] Dynamic subtest vcs0: SUCCESS (7.045s)
[530.668378] Starting dynamic subtest: vcs1
[537.626921] Dynamic subtest vcs1: SUCCESS (6.970s)
[537.639819] Starting dynamic subtest: vecs0
[544.605554] Dynamic subtest vecs0: SUCCESS (6.977s)
[544.618554] Starting dynamic subtest: vecs1
[551.648910] Dynamic subtest vecs1: SUCCESS (7.044s)
[551.661907] Starting dynamic subtest: ccs0
[565.481187] Dynamic subtest ccs0: SUCCESS (13.831s)
[565.482170] Subtest hang: SUCCESS (74.733s)
[565.609907] [102/156] (477s left) kms_flip (flip-vs-suspend)
[567.129035] Starting subtest: flip-vs-suspend
[567.131449] Starting dynamic subtest: A-HDMI-A3
[624.746522] Dynamic subtest A-HDMI-A3: SUCCESS (11.296s)
[624.747890] Subtest flip-vs-suspend: SUCCESS (11.299s)
[632.895542] [103/156] (418s left) gem_mmap_gtt (ptrace)
[632.984065] Subtest ptrace: SKIP (0.000s)
[633.067965] [104/156] (418s left) kms_fbcon_fbt (psr-suspend)
[633.151963] Starting subtest: psr-suspend
[633.153966] Subtest psr-suspend: SKIP (0.000s)
[633.315368] [105/156] (418s left) kms_addfb_basic (bad-pitch-1024)
[633.395983] Starting subtest: bad-pitch-1024
[633.396912] Subtest bad-pitch-1024: SUCCESS (0.000s)
[634.950042] [106/156] (416s left) i915_drm_fdinfo (idle)
[635.042164] Starting subtest: idle
[635.043008] Starting dynamic subtest: rcs0
[635.629298] Dynamic subtest rcs0: SUCCESS (0.592s)
[635.647575] Starting dynamic subtest: bcs0
[636.135288] Dynamic subtest bcs0: SUCCESS (0.508s)
[636.151215] Starting dynamic subtest: vcs0
[636.642218] Dynamic subtest vcs0: SUCCESS (0.508s)
[636.658309] Starting dynamic subtest: vcs1
[637.149055] Dynamic subtest vcs1: SUCCESS (0.507s)
[637.165054] Starting dynamic subtest: vecs0
[637.656220] Dynamic subtest vecs0: SUCCESS (0.507s)
[637.672129] Starting dynamic subtest: vecs1
[638.162702] Dynamic subtest vecs1: SUCCESS (0.507s)
[638.178840] Starting dynamic subtest: ccs0
[638.669540] Dynamic subtest ccs0: SUCCESS (0.507s)
[638.672722] Subtest idle: SUCCESS (3.659s)
[638.816129] [107/156] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[640.329278] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[640.331085] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[640.452976] [108/156] (411s left) gem_exec_reloc (basic-range)
[640.556510] Subtest basic-range: SKIP (0.000s)
[640.632339] [109/156] (410s left) dmabuf_sync_file (import-multiple-read-only)
[640.699293] Starting subtest: import-multiple-read-only
[640.703636] Subtest import-multiple-read-only: SUCCESS (0.005s)
[640.788455] [110/156] (410s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[642.307980] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[642.309977] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[642.460438] [111/156] (409s left) gem_exec_schedule (thriceslice)
[642.575434] Starting subtest: thriceslice
[642.576429] Starting dynamic subtest: rcs0
[642.605878] Dynamic subtest rcs0: SUCCESS (0.031s)
[642.621180] Starting dynamic subtest: bcs0
[642.659655] Dynamic subtest bcs0: SUCCESS (0.053s)
[642.686258] Starting dynamic subtest: vcs0
[642.697431] Dynamic subtest vcs0: SUCCESS (0.036s)
[642.723113] Starting dynamic subtest: vcs1
[642.735294] Dynamic subtest vcs1: SUCCESS (0.036s)
[642.752083] Starting dynamic subtest: vecs0
[642.793810] Dynamic subtest vecs0: SUCCESS (0.057s)
[642.815419] Starting dynamic subtest: vecs1
[642.829274] Dynamic subtest vecs1: SUCCESS (0.034s)
[642.851360] Starting dynamic subtest: ccs0
[642.886488] Dynamic subtest ccs0: SUCCESS (0.056s)
[642.887920] Subtest thriceslice: SUCCESS (0.315s)
[643.276348] [112/156] (408s left) kms_psr (psr2-sprite-blt)
[644.791398] Subtest psr2-sprite-blt: SKIP (0.000s)
[644.848615] [113/156] (407s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[647.464048] Starting subtest: verify-pxp-execution-after-suspend-resume
[647.465944] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[647.563899] [114/156] (404s left) gem_mmap_wc (bad-offset)
[647.644461] Subtest bad-offset: SKIP (0.000s)
[647.723902] [115/156] (404s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[649.499502] Starting subtest: cursor-rapid-movement-256x85
[649.504557] Starting dynamic subtest: pipe-A-HDMI-A-3
[649.942703] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.439s)
[649.980481] Starting dynamic subtest: pipe-D-HDMI-A-3
[650.299251] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.333s)
[650.300198] Subtest cursor-rapid-movement-256x85: SUCCESS (0.801s)
[650.623125] [116/156] (401s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[652.139219] Starting subtest: flip-vs-cursor-legacy
[662.403232] Subtest flip-vs-cursor-legacy: SUCCESS (10.274s)
[662.602780] [117/156] (389s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[664.127074] Starting subtest: fbcpsr-rgb101010-draw-render
[664.128818] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[664.293134] [118/156] (387s left) kms_async_flips (alternate-sync-async-flip-atomic)
[665.846342] Starting subtest: alternate-sync-async-flip-atomic
[666.088781] Starting dynamic subtest: pipe-A-HDMI-A-3
[668.393321] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.303s)
[668.596805] Starting dynamic subtest: pipe-B-HDMI-A-3
[670.664974] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.080s)
[670.863176] Starting dynamic subtest: pipe-C-HDMI-A-3
[672.946759] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.095s)
[673.125483] Starting dynamic subtest: pipe-D-HDMI-A-3
[675.200301] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.087s)
[675.204343] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.353s)
[675.580487] [119/156] (376s left) syncobj_wait (wait-all-snapshot)
[675.662576] Starting subtest: wait-all-snapshot
[675.746035] Subtest wait-all-snapshot: SUCCESS (0.082s)
[675.883248] [120/156] (376s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[677.405105] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[677.406907] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[677.558468] [121/156] (374s left) kms_big_fb (linear-8bpp-rotate-0)
[679.112981] Starting subtest: linear-8bpp-rotate-0
[680.803502] Subtest linear-8bpp-rotate-0: SUCCESS (1.689s)
[681.010754] [122/156] (371s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[682.527409] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[682.584436] [123/156] (370s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[684.111155] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[684.112898] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[684.247473] [124/156] (368s left) gem_userptr_blits (probe)
[684.376536] Starting subtest: probe
[684.505836] Subtest probe: SUCCESS (0.129s)
[684.721046] [125/156] (368s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[686.241078] Starting subtest: psr-rgb565-draw-mmap-gtt
[686.242934] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[686.390867] [126/156] (366s left) kms_draw_crc (draw-method-pwrite)
[687.948236] Starting subtest: draw-method-pwrite
[687.949166] Starting dynamic subtest: xrgb8888-untiled
[688.418117] Dynamic subtest xrgb8888-untiled: SUCCESS (0.469s)
[688.436448] Starting dynamic subtest: rgb565-untiled
[688.852121] Dynamic subtest rgb565-untiled: SUCCESS (0.432s)
[688.871410] Starting dynamic subtest: xrgb2101010-untiled
[689.236734] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.379s)
[689.259021] Starting dynamic subtest: xbgr16161616f-untiled
[689.667959] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.427s)
[689.685462] Starting dynamic subtest: xrgb8888-xtiled
[690.217849] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.548s)
[690.234111] Starting dynamic subtest: rgb565-xtiled
[690.801133] Dynamic subtest rgb565-xtiled: SUCCESS (0.582s)
[690.818226] Starting dynamic subtest: xrgb2101010-xtiled
[691.335399] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.532s)
[691.355012] Starting dynamic subtest: xbgr16161616f-xtiled
[691.967313] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.631s)
[691.983245] Starting dynamic subtest: xrgb8888-4tiled
[692.400712] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.432s)
[692.417528] Starting dynamic subtest: rgb565-4tiled
[692.735118] Dynamic subtest rgb565-4tiled: SUCCESS (0.332s)
[692.788658] Starting dynamic subtest: xrgb2101010-4tiled
[693.183688] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.445s)
[693.199735] Starting dynamic subtest: xbgr16161616f-4tiled
[693.816951] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.632s)
[693.817964] Subtest draw-method-pwrite: SUCCESS (5.871s)
[693.991508] [127/156] (359s left) kms_properties (crtc-properties-legacy)
[695.506358] Starting subtest: crtc-properties-legacy
[695.507340] Starting dynamic subtest: pipe-A-HDMI-A-3
[695.827618] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.320s)
[695.865714] Starting dynamic subtest: pipe-B-HDMI-A-3
[696.136752] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.305s)
[696.152665] Starting dynamic subtest: pipe-C-HDMI-A-3
[696.421292] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.283s)
[696.437546] Starting dynamic subtest: pipe-D-HDMI-A-3
[696.704605] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.282s)
[696.705542] Subtest crtc-properties-legacy: SUCCESS (1.200s)
[696.921205] [128/156] (356s left) gem_mmap_gtt (basic-small-copy-odd)
[697.003443] Subtest basic-small-copy-odd: SKIP (0.000s)
[697.072801] [129/156] (356s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[698.598222] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[701.323497] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.727s)
[701.507463] [130/156] (351s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[703.040368] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[704.339559] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.299s)
[704.588922] [131/156] (348s left) gem_mmap_wc (write-read-distinct)
[704.673320] Subtest write-read-distinct: SKIP (0.000s)
[704.758787] [132/156] (348s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[706.278170] Starting subtest: 2x-flip-vs-cursor-atomic
[706.281204] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[706.377765] [133/156] (347s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[707.909149] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[707.910996] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[708.060222] [134/156] (345s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[709.610844] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[709.612626] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[709.746967] [135/156] (343s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt)
[711.294092] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt
[711.296104] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[711.475280] [136/156] (342s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[713.003262] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[713.004226] Starting dynamic subtest: pipe-A-HDMI-A-3
[713.013159] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[713.027541] Starting dynamic subtest: pipe-B-HDMI-A-3
[713.036724] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[713.050544] Starting dynamic subtest: pipe-C-HDMI-A-3
[713.060578] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[713.074446] Starting dynamic subtest: pipe-D-HDMI-A-3
[713.086589] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[713.088778] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[713.334102] [137/156] (340s left) kms_cursor_crc (cursor-offscreen-256x256)
[715.082395] Starting subtest: cursor-offscreen-256x256
[715.086399] Starting dynamic subtest: pipe-A-HDMI-A-3
[717.542262] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.457s)
[717.579379] Starting dynamic subtest: pipe-D-HDMI-A-3
[719.968586] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.402s)
[719.969578] Subtest cursor-offscreen-256x256: SUCCESS (4.888s)
[720.370870] [138/156] (333s left) perf (gen12-unprivileged-single-ctx-counters)
[720.596514] Starting subtest: gen12-unprivileged-single-ctx-counters
[720.597499] Starting dynamic subtest: rcs0
[720.695651] Dynamic subtest rcs0: SUCCESS (0.098s)
[720.696543] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.100s)
[720.764090] [139/156] (333s left) kms_psr (psr-suspend)
[722.313568] Subtest psr-suspend: SKIP (0.000s)
[722.377675] [140/156] (331s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[723.903131] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[723.904920] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[724.073572] [141/156] (330s left) gem_exec_reloc (basic-cpu-active)
[724.181953] Subtest basic-cpu-active: SKIP (0.000s)
[724.262349] [142/156] (329s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[725.790632] Starting subtest: yf-tiled-8bpp-rotate-0
[725.792389] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[725.944723] [143/156] (328s left) kms_plane (plane-panning-bottom-right-suspend)
[727.486183] Starting subtest: plane-panning-bottom-right-suspend
[727.487177] Starting dynamic subtest: pipe-A
[746.905695] Dynamic subtest pipe-A: SUCCESS (4.456s)
[746.919977] Starting dynamic subtest: pipe-B
[766.899965] Dynamic subtest pipe-B: SUCCESS (3.894s)
[766.900914] Subtest plane-panning-bottom-right-suspend: SUCCESS (8.354s)
[773.136869] [144/156] (287s left) kms_lease (master-vs-lease)
[774.660714] Starting subtest: master-vs-lease
[774.661716] Subtest master-vs-lease: SUCCESS (0.002s)
[774.891314] [145/156] (285s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[776.416437] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[776.418071] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[776.573416] [146/156] (284s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[778.119731] Starting subtest: fbc-rgb101010-draw-pwrite
[778.991725] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (0.847s)
[779.221483] [147/156] (281s left) gem_exec_reloc (basic-cpu)
[779.312351] Subtest basic-cpu: SKIP (0.000s)
[779.406876] [148/156] (281s left) gem_userptr_blits (process-exit)
[779.505152] Starting subtest: process-exit
[779.515318] Subtest process-exit: SUCCESS (0.010s)
[779.699580] [149/156] (281s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[781.262843] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[781.264679] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[781.410840] [150/156] (279s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[782.991737] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[782.993609] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[783.163829] [151/156] (277s left) gem_exec_reloc (basic-cpu-read-noreloc)
[783.270493] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[783.360991] [152/156] (277s left) kms_async_flips (invalid-async-flip-atomic)
[784.904018] Starting subtest: invalid-async-flip-atomic
[785.144175] Starting dynamic subtest: pipe-A-HDMI-A-3
[785.546835] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.397s)
[785.722155] Starting dynamic subtest: pipe-B-HDMI-A-3
[785.830347] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.119s)
[786.000137] Starting dynamic subtest: pipe-C-HDMI-A-3
[786.109149] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.119s)
[786.276942] Starting dynamic subtest: pipe-D-HDMI-A-3
[786.390765] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.126s)
[786.391817] Subtest invalid-async-flip-atomic: SUCCESS (1.467s)
[786.748960] [153/156] (274s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[788.288661] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[788.290522] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[788.439467] [154/156] (272s left) gem_ctx_persistence (idempotent)
[788.555826] Starting subtest: idempotent
[788.556788] Subtest idempotent: SUCCESS (0.000s)
[788.703841] [155/156] (272s left) kms_psr (pr-cursor-plane-move)
[790.242367] Subtest pr-cursor-plane-move: SKIP (0.000s)
[790.304675] [156/156] (271s left) gem_exec_params (invalid-fence-in-submit)
[790.393048] Starting subtest: invalid-fence-in-submit
[790.395477] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[790.572692] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: i915_hangman
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: syncobj_eventfd
results: parsing output: 15/ for test: gem_reg_read
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: gem_exec_flush
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: prime_mmap
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: template
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_chamelium_hpd
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_vblank
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_media_vme
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_debugfs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: prime_mmap
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_joiner
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_plane_lowres
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: kms_prop_blob
results: parsing output: 67/ for test: kms_color_pipeline
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_ctx_param
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_request_retire
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: gem_tiled_pread_basic
results: parsing output: 88/ for test: kms_plane_alpha_blend
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_psr2_su
results: parsing output: 91/ for test: gem_fence_thrash
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_sequence
results: parsing output: 95/ for test: gem_barrier_race
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: sysfs_preempt_timeout
results: parsing output: 100/ for test: prime_busy
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_fbcon_fbt
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: dmabuf_sync_file
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_draw_crc
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_mmap_wc
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_big_fb
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_ccs
results: parsing output: 136/ for test: kms_cursor_crc
results: parsing output: 137/ for test: perf
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_exec_reloc
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: kms_plane
results: parsing output: 143/ for test: kms_lease
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_exec_reloc
results: parsing output: 147/ for test: gem_userptr_blits
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_exec_reloc
results: parsing output: 151/ for test: kms_async_flips
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_ctx_persistence
results: parsing output: 154/ for test: kms_psr
results: parsing output: 155/ for test: gem_exec_params
Done.