[57.771258] Initializing watchdogs
[57.771303]   /dev/watchdog0
[57.784338] [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.788772] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.790810] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.792914] [001/130] (960s left) gem_userptr_blits (sync-unmap-after-close)
[57.922247] Starting subtest: sync-unmap-after-close
[57.939256] Subtest sync-unmap-after-close: SUCCESS (0.017s)
[58.074898] [002/130] (960s left) kms_cursor_crc (cursor-random-64x64)
[58.230183] Starting subtest: cursor-random-64x64
[58.242756] Starting dynamic subtest: pipe-A-eDP-1
[61.914739] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.699s)
[61.943251] Starting dynamic subtest: pipe-D-eDP-1
[66.127610] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.205s)
[66.128628] Subtest cursor-random-64x64: SUCCESS (7.941s)
[66.964957] [003/130] (951s left) gen9_exec_parse (bb-start-param)
[67.033084] Subtest bb-start-param: SKIP (0.000s)
[67.088366] [004/130] (951s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[67.134247] Subtest no-spare-fences-busy: SKIP (0.000s)
[67.193574] [005/130] (951s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[67.296117] Starting subtest: fbc-tiling-linear
[70.018662] Subtest fbc-tiling-linear: SUCCESS (2.729s)
[70.157770] [006/130] (948s left) kms_big_fb (linear-16bpp-rotate-90)
[70.262807] Starting subtest: linear-16bpp-rotate-90
[70.282135] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[70.396711] [007/130] (948s left) syncobj_basic (bad-destroy-pad)
[70.447417] Starting subtest: bad-destroy-pad
[70.448528] Subtest bad-destroy-pad: SUCCESS (0.000s)
[70.541699] [008/130] (947s left) i915_pm_rpm (gem-execbuf-stress)
[72.070151] Starting subtest: gem-execbuf-stress
[72.071484] Starting dynamic subtest: smem0
[84.995933] Dynamic subtest smem0: SUCCESS (12.934s)
[85.004720] Starting dynamic subtest: extra-wait-smem0
[147.072574] Dynamic subtest extra-wait-smem0: SUCCESS (62.077s)
[147.074055] Subtest gem-execbuf-stress: SUCCESS (75.012s)
[147.424301] [009/130] (871s left) gem_exec_params (cliprects_ptr-dirt)
[147.480723] Starting subtest: cliprects_ptr-dirt
[147.481578] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[147.586143] [010/130] (870s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[147.685663] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[152.540240] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (4.854s)
[152.643800] [011/130] (865s left) kms_atomic_transition (plane-all-transition-nonblocking)
[152.740869] Starting subtest: plane-all-transition-nonblocking
[152.741788] Starting dynamic subtest: pipe-A-eDP-1
[155.246521] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[155.529989] Starting dynamic subtest: pipe-B-eDP-1
[158.793771] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.267s)
[159.067458] Subtest plane-all-transition-nonblocking: SUCCESS (6.324s)
[159.891562] [012/130] (858s left) gem_exec_fence (syncobj-timeline-export)
[160.436470] Starting subtest: syncobj-timeline-export
[160.440584] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[162.039984] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[162.041578] [013/130] (856s left) kms_atomic_interruptible (legacy-setmode)
[162.136073] Starting subtest: legacy-setmode
[162.137063] Starting dynamic subtest: pipe-A-eDP-1
[169.020256] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.882s)
[169.021182] Subtest legacy-setmode: SUCCESS (6.883s)
[169.870497] [014/130] (848s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[169.966084] Starting subtest: fbcpsr-shrfb-scaledprimary
[175.699070] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.734s)
[175.852527] [015/130] (842s left) gem_exec_balancer (parallel-balancer)
[176.104757] Starting subtest: parallel-balancer
[176.819734] Subtest parallel-balancer: SUCCESS (0.716s)
[176.910017] [016/130] (841s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[177.019703] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[177.021690] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[177.103021] [017/130] (841s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[177.162925] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[177.240216] [018/130] (841s left) gem_softpin (evict-prime-sanity-check)
[177.295041] Starting subtest: evict-prime-sanity-check
[177.296079] Starting dynamic subtest: rcs0
[178.446721] Dynamic subtest rcs0: SUCCESS (1.151s)
[178.454906] Starting dynamic subtest: bcs0
[179.607292] Dynamic subtest bcs0: SUCCESS (1.160s)
[179.615303] Starting dynamic subtest: vcs0
[180.923193] Dynamic subtest vcs0: SUCCESS (1.313s)
[180.932848] Starting dynamic subtest: vcs1
[182.977340] Dynamic subtest vcs1: SUCCESS (2.053s)
[182.985789] Starting dynamic subtest: vecs0
[184.957384] Dynamic subtest vecs0: SUCCESS (1.979s)
[184.965967] Starting dynamic subtest: ccs0
[186.085616] Dynamic subtest ccs0: SUCCESS (1.130s)
[186.093356] Starting dynamic subtest: all
[187.220785] Dynamic subtest all: SUCCESS (1.135s)
[187.222362] Subtest evict-prime-sanity-check: SUCCESS (9.925s)
[187.292610] [019/130] (831s left) kms_lease (page-flip-implicit-plane)
[187.391614] Starting subtest: page-flip-implicit-plane
[187.392598] Starting dynamic subtest: pipe-A-eDP-1
[187.872028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[187.879737] Starting dynamic subtest: pipe-B-eDP-1
[188.962037] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.089s)
[188.968088] Starting dynamic subtest: pipe-C-eDP-1
[190.073879] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[190.079864] Starting dynamic subtest: pipe-D-eDP-1
[191.204557] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[191.205893] Subtest page-flip-implicit-plane: SUCCESS (3.811s)
[192.034594] [020/130] (826s left) gem_ctx_isolation (preservation-reset)
[192.203826] Starting subtest: preservation-reset
[192.205340] Starting dynamic subtest: rcs0
[192.605082] Dynamic subtest rcs0: SUCCESS (0.401s)
[192.613126] Starting dynamic subtest: bcs0
[193.076974] Dynamic subtest bcs0: SUCCESS (0.472s)
[193.083243] Starting dynamic subtest: vcs0
[193.542214] Dynamic subtest vcs0: SUCCESS (0.465s)
[193.551105] Starting dynamic subtest: vcs1
[195.377650] Dynamic subtest vcs1: SUCCESS (1.836s)
[195.386502] Starting dynamic subtest: vecs0
[197.366855] Dynamic subtest vecs0: SUCCESS (1.989s)
[197.375708] Starting dynamic subtest: ccs0
[199.402734] Dynamic subtest ccs0: SUCCESS (2.035s)
[199.404046] Subtest preservation-reset: SUCCESS (7.201s)
[199.607291] [021/130] (819s left) gem_flink_race (flink_name)
[199.638526] Starting subtest: flink_name
[205.034585] Subtest flink_name: SUCCESS (5.394s)
[205.129735] [022/130] (813s left) gem_ctx_shared (disjoint-timelines)
[205.197787] Starting subtest: disjoint-timelines
[205.236191] Subtest disjoint-timelines: SUCCESS (0.038s)
[205.495374] [023/130] (813s left) gen7_exec_parse (chained-batch)
[205.549962] Subtest chained-batch: SKIP (0.000s)
[205.608145] [024/130] (813s left) sw_sync (sync_expired_merge)
[205.637057] Starting subtest: sync_expired_merge
[206.712554] Subtest sync_expired_merge: SUCCESS (1.074s)
[206.764916] [025/130] (812s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[206.867809] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[206.868869] Starting dynamic subtest: pipe-A-eDP-1
[206.892136] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[206.899342] Starting dynamic subtest: pipe-B-eDP-1
[206.920878] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[206.926878] Starting dynamic subtest: pipe-C-eDP-1
[206.948261] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[206.954622] Starting dynamic subtest: pipe-D-eDP-1
[206.977675] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[206.979315] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s)
[209.087949] [026/130] (809s left) syncobj_timeline (device-submit-unordered)
[209.152245] Starting subtest: device-submit-unordered
[209.153218] Subtest device-submit-unordered: SUCCESS (0.000s)
[209.259840] [027/130] (809s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[209.312185] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[209.363574] [028/130] (809s left) syncobj_timeline (etime-single-wait-all-submitted)
[209.419509] Starting subtest: etime-single-wait-all-submitted
[209.526554] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[209.593680] [029/130] (809s left) gem_exec_reloc (basic-wc-gtt)
[209.652168] Subtest basic-wc-gtt: SKIP (0.000s)
[209.711320] [030/130] (809s left) gem_lmem_swapping (heavy-verify-random-ccs)
[209.749992] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[209.789551] [031/130] (809s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[209.850082] Starting subtest: invalid-single-wait-unsubmitted
[209.851142] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[209.946255] [032/130] (809s left) intel_hwmon (hwmon-write)
[210.002513] Subtest hwmon-write: SKIP (0.000s)
[210.056429] [033/130] (809s left) core_auth (many-magics)
[210.112147] Starting subtest: many-magics
[210.945968] Subtest many-magics: SUCCESS (0.836s)
[211.077643] [034/130] (808s left) gem_exec_whisper (basic-fds-all)
[211.142063] Starting subtest: basic-fds-all
[222.645128] Subtest basic-fds-all: SUCCESS (11.501s)
[222.824052] [035/130] (796s left) gem_userptr_blits (sd-probe)
[222.884191] Starting subtest: sd-probe
[222.885085] Subtest sd-probe: SUCCESS (0.000s)
[223.030895] [036/130] (796s left) kms_psr (fbc-pr-sprite-plane-move)
[223.119822] Starting subtest: fbc-pr-sprite-plane-move
[223.121784] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[223.182940] [037/130] (796s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[223.287994] Starting subtest: yf-tiled-16bpp-rotate-270
[223.289933] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[223.386423] [038/130] (795s left) kms_addfb_basic (unused-pitches)
[223.439674] Starting subtest: unused-pitches
[223.440726] Subtest unused-pitches: SUCCESS (0.000s)
[223.580789] [039/130] (795s left) kms_vblank (query-forked-busy-hang)
[223.665764] Starting subtest: query-forked-busy-hang
[223.668357] Starting dynamic subtest: pipe-A-eDP-1
[249.777148] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.109s)
[249.787335] Starting dynamic subtest: pipe-D-eDP-1
[274.671304] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.891s)
[274.672149] Subtest query-forked-busy-hang: SUCCESS (51.004s)
[275.447831] [040/130] (743s left) kms_addfb_basic (clobberred-modifier)
[275.494458] Starting subtest: clobberred-modifier
[275.496496] Subtest clobberred-modifier: SKIP (0.000s)
[275.615659] [041/130] (743s left) dmabuf_sync_file (import-basic)
[275.651813] Starting subtest: import-basic
[275.652805] Subtest import-basic: SUCCESS (0.002s)
[275.701465] [042/130] (743s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[275.803503] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[276.825239] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.023s)
[276.964849] [043/130] (742s left) kms_cursor_crc (cursor-sliding-128x42)
[277.169933] Starting subtest: cursor-sliding-128x42
[277.217576] Subtest cursor-sliding-128x42: SKIP (0.046s)
[277.424392] [044/130] (742s left) gem_tiled_partial_pwrite_pread (reads)
[277.480189] Subtest reads: SKIP (0.000s)
[277.547955] [045/130] (741s left) gem_readwrite (new-obj)
[277.606278] Subtest new-obj: SKIP (0.000s)
[277.666823] [046/130] (741s left) gem_pread (exhaustion)
[277.724627] Subtest exhaustion: SKIP (0.000s)
[277.776595] [047/130] (741s left) kms_plane (planar-pixel-format-settings)
[277.864643] Starting subtest: planar-pixel-format-settings
[277.895941] Subtest planar-pixel-format-settings: SUCCESS (0.031s)
[277.998369] [048/130] (741s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[278.096690] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[282.389113] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.292s)
[282.520127] [049/130] (737s left) kms_selftest (drm_format_helper)
[282.559261] Starting subtest: drm_format_helper
[282.594323] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[282.734143] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.141s)
[282.742379] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[282.877873] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.141s)
[282.886079] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[283.010048] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.133s)
[283.018048] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[283.137269] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.127s)
[283.145557] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[283.278595] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.140s)
[283.285752] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[283.377031] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.098s)
[283.383549] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[283.507349] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.131s)
[283.515556] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[283.640255] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.131s)
[283.647736] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[283.775653] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.133s)
[283.783538] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[283.894190] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.118s)
[283.902148] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[284.025731] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.131s)
[284.034081] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[284.150097] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.125s)
[284.158242] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[284.271195] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.120s)
[284.279972] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[284.351837] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.081s)
[284.358172] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[284.480817] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.128s)
[284.489088] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[284.627200] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.145s)
[284.633926] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_build_fourcc_list
[284.775818] Dynamic subtest drm_format_helper_test-drm_test_fb_build_fourcc_list: SUCCESS (0.149s)
[284.783061] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[284.921213] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.144s)
[284.922084] Subtest drm_format_helper: SUCCESS (2.361s)
[285.121352] [050/130] (734s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[285.231140] Starting subtest: flip-vs-cursor-atomic
[292.129733] Subtest flip-vs-cursor-atomic: SUCCESS (6.896s)
[292.921364] [051/130] (726s left) kms_addfb_basic (bad-pitch-128)
[292.974628] Starting subtest: bad-pitch-128
[292.975569] Subtest bad-pitch-128: SUCCESS (0.000s)
[293.113228] [052/130] (726s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[293.199758] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[298.470580] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.272s)
[298.590615] [053/130] (721s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[298.700822] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[299.778869] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.078s)
[299.915513] [054/130] (719s left) gem_userptr_blits (usage-restrictions)
[299.966871] Starting subtest: usage-restrictions
[299.967984] Subtest usage-restrictions: SUCCESS (0.000s)
[300.107890] [055/130] (719s left) gem_eio (kms)
[300.403439] Starting subtest: kms
[323.059469] Subtest kms: SUCCESS (22.656s)
[324.217192] [056/130] (695s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[324.269918] Starting subtest: multi-wait-for-submit-available-submitted
[324.270952] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[324.370346] [057/130] (695s left) gem_exec_params (dr4-dirt)
[324.427184] Starting subtest: DR4-dirt
[324.428307] Subtest DR4-dirt: SUCCESS (0.000s)
[324.540195] [058/130] (695s left) gem_exec_schedule (preemptive-hang)
[324.707042] Starting subtest: preemptive-hang
[324.708791] Starting dynamic subtest: rcs0
[334.037801] Dynamic subtest rcs0: SUCCESS (9.330s)
[334.045988] Starting dynamic subtest: bcs0
[343.052763] Dynamic subtest bcs0: SUCCESS (9.014s)
[343.061367] Starting dynamic subtest: vcs0
[352.017731] Dynamic subtest vcs0: SUCCESS (8.964s)
[352.025497] Starting dynamic subtest: vcs1
[361.039687] Dynamic subtest vcs1: SUCCESS (9.021s)
[361.047858] Starting dynamic subtest: vecs0
[370.081888] Dynamic subtest vecs0: SUCCESS (9.017s)
[370.095566] Starting dynamic subtest: ccs0
[379.020730] Dynamic subtest ccs0: SUCCESS (8.963s)
[379.021719] Subtest preemptive-hang: SUCCESS (54.316s)
[379.278360] [059/130] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[379.380723] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[379.382428] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[379.492338] [060/130] (640s left) gem_exec_parallel (contexts)
[379.543238] Starting subtest: contexts
[379.544285] Starting dynamic subtest: rcs0
[382.249479] Dynamic subtest rcs0: SUCCESS (2.703s)
[382.259822] Starting dynamic subtest: bcs0
[385.680373] Dynamic subtest bcs0: SUCCESS (3.429s)
[385.689291] Starting dynamic subtest: vcs0
[389.417708] Dynamic subtest vcs0: SUCCESS (3.736s)
[389.427964] Starting dynamic subtest: vcs1
[393.415227] Dynamic subtest vcs1: SUCCESS (3.996s)
[393.425243] Starting dynamic subtest: vecs0
[397.388347] Dynamic subtest vecs0: SUCCESS (3.971s)
[397.397985] Starting dynamic subtest: ccs0
[401.168301] Dynamic subtest ccs0: SUCCESS (3.780s)
[401.169129] Subtest contexts: SUCCESS (21.623s)
[401.347191] [061/130] (618s left) kms_invalid_mode (overflow-vrefresh)
[401.450614] Starting subtest: overflow-vrefresh
[401.451567] Starting dynamic subtest: pipe-A-eDP-1
[401.733811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[401.743065] Starting dynamic subtest: pipe-B-eDP-1
[401.744038] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[401.750455] Starting dynamic subtest: pipe-C-eDP-1
[401.751401] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[401.757787] Starting dynamic subtest: pipe-D-eDP-1
[401.758645] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[401.759523] Subtest overflow-vrefresh: SUCCESS (0.287s)
[402.527896] [062/130] (617s left) kms_pm_lpsp (kms-lpsp)
[403.620401] Starting subtest: kms-lpsp
[403.621314] Starting dynamic subtest: pipe-A-eDP-1
[403.783890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.163s)
[404.078242] Subtest kms-lpsp: SUCCESS (0.458s)
[404.861242] [063/130] (615s left) kms_content_protection (type1)
[405.040422] Starting subtest: type1
[408.383056] Subtest type1: SKIP (3.342s)
[409.558296] [064/130] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[409.666674] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[409.668327] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[409.771861] [065/130] (610s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[409.862902] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[409.863830] Starting dynamic subtest: pipe-A-eDP-1
[409.871776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[409.878946] Starting dynamic subtest: pipe-B-eDP-1
[409.887106] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[409.894278] Starting dynamic subtest: pipe-C-eDP-1
[409.902256] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[409.909814] Starting dynamic subtest: pipe-D-eDP-1
[409.917529] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[409.918378] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[412.013574] [066/130] (608s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[417.089872] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[417.092039] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[417.915096] [067/130] (602s left) gem_mmap_gtt (fault-concurrent-y)
[417.964218] Subtest fault-concurrent-Y: SKIP (0.000s)
[418.013778] [068/130] (602s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[418.087935] Starting subtest: map-fixed-invalidate-overlap-busy
[418.089870] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[418.217423] [069/130] (602s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[418.304898] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[418.307207] Starting dynamic subtest: pipe-A-default-mode
[418.592461] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[418.594368] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.286s)
[419.438108] [070/130] (600s left) gem_userptr_blits (dmabuf-sync)
[419.512720] Starting subtest: dmabuf-sync
[419.516068] Subtest dmabuf-sync: SKIP (0.002s)
[419.645955] [071/130] (600s left) kms_flip (dpms-off-confusion)
[419.744355] Starting subtest: dpms-off-confusion
[419.746509] Starting dynamic subtest: A-eDP1
[428.443374] Dynamic subtest A-eDP1: SUCCESS (8.697s)
[428.453092] Starting dynamic subtest: B-eDP1
[437.162732] Dynamic subtest B-eDP1: SUCCESS (8.717s)
[437.172136] Starting dynamic subtest: C-eDP1
[445.876612] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[445.884858] Starting dynamic subtest: D-eDP1
[454.597483] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[454.600138] Subtest dpms-off-confusion: SUCCESS (34.855s)
[455.746425] [072/130] (564s left) kms_pm_backlight (basic-brightness)
[455.848279] Starting subtest: basic-brightness
[455.946059] Starting dynamic subtest: eDP-1
[456.439968] Dynamic subtest eDP-1: SUCCESS (0.493s)
[456.441254] Subtest basic-brightness: SUCCESS (0.591s)
[457.268881] [073/130] (563s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[457.357930] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[457.358879] Starting dynamic subtest: pipe-A-default-mode
[460.087449] Dynamic subtest pipe-A-default-mode: SUCCESS (2.728s)
[460.088451] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.729s)
[460.945998] [074/130] (559s left) gem_exec_store (basic)
[461.002732] Starting subtest: basic
[461.120724] Subtest basic: SUCCESS (0.118s)
[461.299009] [075/130] (559s left) gem_pxp (verify-pxp-stale-ctx-execution)
[461.416421] Starting subtest: verify-pxp-stale-ctx-execution
[462.474894] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[462.591469] [076/130] (557s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[462.685627] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[462.687432] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[462.781920] [077/130] (557s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[462.888736] Starting subtest: 4-tiled-8bpp-rotate-180
[464.011023] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.123s)
[464.182705] [078/130] (556s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[469.192600] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[469.194077] Starting dynamic subtest: pipe-A-eDP-1
[475.823377] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.628s)
[475.830465] Starting dynamic subtest: pipe-B-eDP-1
[482.353885] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.528s)
[482.354924] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.160s)
[483.216913] [079/130] (537s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[483.337882] Starting subtest: basic-busy-flip-before-cursor-legacy
[483.339770] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[483.472886] [080/130] (537s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[483.569728] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[483.571493] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[483.680376] [081/130] (536s left) kms_cdclk (mode-transition-all-outputs)
[483.761771] Starting subtest: mode-transition-all-outputs
[484.047129] Subtest mode-transition-all-outputs: SKIP (0.284s)
[484.850254] [082/130] (535s left) kms_dp_link_training (non-uhbr-sst)
[484.950711] Starting subtest: non-uhbr-sst
[484.954069] Subtest non-uhbr-sst: SKIP (0.000s)
[485.014106] [083/130] (535s left) api_intel_allocator (two-level-inception)
[485.066488] Starting subtest: two-level-inception
[490.478088] Subtest two-level-inception: SUCCESS (5.410s)
[490.594534] [084/130] (530s left) gem_cs_tlb (engines)
[490.651026] Starting subtest: engines
[490.652112] Starting dynamic subtest: rcs0
[492.808525] Dynamic subtest rcs0: SUCCESS (2.155s)
[492.819336] Starting dynamic subtest: bcs0
[494.964234] Dynamic subtest bcs0: SUCCESS (2.154s)
[494.972093] Starting dynamic subtest: vcs0
[497.119371] Dynamic subtest vcs0: SUCCESS (2.153s)
[497.128525] Starting dynamic subtest: vcs1
[499.273165] Dynamic subtest vcs1: SUCCESS (2.154s)
[499.282229] Starting dynamic subtest: vecs0
[501.426986] Dynamic subtest vecs0: SUCCESS (2.153s)
[501.434149] Starting dynamic subtest: ccs0
[503.584094] Dynamic subtest ccs0: SUCCESS (2.156s)
[503.584943] Subtest engines: SUCCESS (12.931s)
[503.688197] [085/130] (517s left) syncobj_basic (bad-pad-handle-to-fd)
[503.742810] Starting subtest: bad-pad-handle-to-fd
[503.743807] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[503.835795] [086/130] (516s left) prime_busy (hang-wait)
[503.888945] Starting subtest: hang-wait
[503.891569] Starting dynamic subtest: rcs0
[531.391489] Dynamic subtest rcs0: SUCCESS (27.499s)
[531.398422] Starting dynamic subtest: bcs0
[538.550799] Dynamic subtest bcs0: SUCCESS (7.156s)
[538.558739] Starting dynamic subtest: vcs0
[545.525350] Dynamic subtest vcs0: SUCCESS (6.973s)
[545.532918] Starting dynamic subtest: vcs1
[552.505960] Dynamic subtest vcs1: SUCCESS (6.977s)
[552.514588] Starting dynamic subtest: vecs0
[559.539824] Dynamic subtest vecs0: SUCCESS (7.032s)
[559.547557] Starting dynamic subtest: ccs0
[573.373907] Dynamic subtest ccs0: SUCCESS (13.835s)
[573.375333] Subtest hang-wait: SUCCESS (69.482s)
[573.490835] [087/130] (447s left) kms_psr (fbc-psr-sprite-render)
[573.599363] Starting subtest: fbc-psr-sprite-render
[573.600229] Starting dynamic subtest: eDP-1
[573.601819] Dynamic subtest eDP-1: SKIP (0.000s)
[573.603460] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[573.665326] [088/130] (447s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[573.796441] Starting subtest: short-busy-flip-before-cursor-toggle
[573.797986] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[573.925608] [089/130] (446s left) gem_ccs (block-copy-compressed)
[573.987318] Starting subtest: block-copy-compressed
[573.989358] Subtest block-copy-compressed: SKIP (0.000s)
[574.087074] [090/130] (446s left) gem_partial_pwrite_pread (writes-after-reads-display)
[574.147132] Subtest writes-after-reads-display: SKIP (0.000s)
[574.213646] [091/130] (446s left) syncobj_wait (reset-multiple-signaled)
[574.270114] Starting subtest: reset-multiple-signaled
[574.271092] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[574.365739] [092/130] (446s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[574.469453] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[574.471302] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[574.566942] [093/130] (446s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[574.656691] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[579.563064] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.908s)
[579.680695] [094/130] (441s left) kms_async_flips (test-time-stamp-atomic)
[579.776891] Starting subtest: test-time-stamp-atomic
[580.145614] Starting dynamic subtest: pipe-A-eDP-1
[580.994075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s)
[581.359078] Starting dynamic subtest: pipe-B-eDP-1
[582.119757] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[582.482944] Starting dynamic subtest: pipe-C-eDP-1
[583.242238] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[583.603730] Starting dynamic subtest: pipe-D-eDP-1
[584.367431] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[584.368596] Subtest test-time-stamp-atomic: SUCCESS (4.589s)
[585.507057] [095/130] (435s left) gem_mmap_wc (bad-offset)
[585.569095] Subtest bad-offset: SKIP (0.000s)
[585.616427] [096/130] (435s left) gem_exec_suspend (basic-s3-devices)
[585.684363] Starting subtest: basic-S3-devices
[585.685499] Starting dynamic subtest: smem
[598.954619] Dynamic subtest smem: SUCCESS (13.267s)
[598.955884] Subtest basic-S3-devices: SUCCESS (13.268s)
[607.150847] [097/130] (422s left) gem_exec_schedule (deep)
[607.340280] Starting subtest: deep
[607.341334] Starting dynamic subtest: rcs0
[612.774062] Dynamic subtest rcs0: SKIP (5.430s)
[612.783883] Starting dynamic subtest: vcs0
[622.443935] Dynamic subtest vcs0: SUCCESS (9.670s)
[622.452808] Starting dynamic subtest: vcs1
[632.450892] Dynamic subtest vcs1: SUCCESS (10.005s)
[632.461716] Starting dynamic subtest: vecs0
[643.564336] Dynamic subtest vecs0: SUCCESS (11.113s)
[643.573192] Starting dynamic subtest: ccs0
[654.485762] Dynamic subtest ccs0: SUCCESS (10.920s)
[654.487199] Subtest deep: SUCCESS (47.141s)
[656.368887] [098/130] (372s left) kms_color (ctm-0-50)
[656.473828] Starting subtest: ctm-0-50
[656.474732] Starting dynamic subtest: pipe-A-eDP-1
[659.831053] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.356s)
[659.839403] Starting dynamic subtest: pipe-B-eDP-1
[663.887470] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.056s)
[663.895552] Starting dynamic subtest: pipe-C-eDP-1
[667.848212] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.960s)
[667.856281] Starting dynamic subtest: pipe-D-eDP-1
[671.853260] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.005s)
[671.854588] Subtest ctm-0-50: SUCCESS (15.379s)
[672.658012] [099/130] (356s left) perf_pmu (semaphore-wait)
[672.696218] Starting subtest: semaphore-wait
[672.697180] Starting dynamic subtest: rcs0
[673.212100] Dynamic subtest rcs0: SUCCESS (0.512s)
[673.222048] Starting dynamic subtest: bcs0
[673.724575] Dynamic subtest bcs0: SUCCESS (0.510s)
[673.734420] Starting dynamic subtest: vcs0
[674.237144] Dynamic subtest vcs0: SUCCESS (0.510s)
[674.252330] Starting dynamic subtest: vcs1
[674.750062] Dynamic subtest vcs1: SUCCESS (0.510s)
[674.760076] Starting dynamic subtest: vecs0
[675.264243] Dynamic subtest vecs0: SUCCESS (0.511s)
[675.274368] Starting dynamic subtest: ccs0
[675.781838] Dynamic subtest ccs0: SUCCESS (0.515s)
[675.783516] Subtest semaphore-wait: SUCCESS (3.083s)
[676.976040] [100/130] (352s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[677.083546] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[677.085268] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[677.183225] [101/130] (352s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[677.277454] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[677.279380] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[677.376571] [102/130] (351s left) gem_mmap (bad-object)
[677.425988] Subtest bad-object: SKIP (0.000s)
[677.480200] [103/130] (351s left) dumb_buffer (map-valid)
[677.529412] Starting subtest: map-valid
[677.530501] Subtest map-valid: SUCCESS (0.000s)
[677.618485] [104/130] (351s left) kms_rmfb (close-fd)
[677.706733] Starting subtest: close-fd
[677.708377] Starting dynamic subtest: pipe-A-eDP-1
[677.826104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.117s)
[677.834785] Starting dynamic subtest: pipe-B-eDP-1
[679.019159] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[679.028522] Starting dynamic subtest: pipe-C-eDP-1
[680.147397] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[680.155622] Starting dynamic subtest: pipe-D-eDP-1
[681.266280] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[681.267242] Subtest close-fd: SUCCESS (3.561s)
[682.464383] [105/130] (346s left) kms_flip (2x-flip-vs-suspend-interruptible)
[682.561236] Starting subtest: 2x-flip-vs-suspend-interruptible
[682.573346] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[682.645181] [106/130] (346s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[682.749586] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[682.751443] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[682.862092] [107/130] (346s left) syncobj_timeline (wait-all-delayed-signal)
[682.923120] Starting subtest: wait-all-delayed-signal
[683.027163] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[683.097261] [108/130] (346s left) i915_hangman (gt-engine-hang)
[683.158572] Starting subtest: gt-engine-hang
[683.159565] Starting dynamic subtest: rcs0
[684.873042] Dynamic subtest rcs0: SUCCESS (1.712s)
[684.884214] Starting dynamic subtest: bcs0
[686.920638] Dynamic subtest bcs0: SUCCESS (2.045s)
[686.931741] Starting dynamic subtest: vcs0
[688.904086] Dynamic subtest vcs0: SUCCESS (1.980s)
[688.915244] Starting dynamic subtest: vcs1
[690.888793] Dynamic subtest vcs1: SUCCESS (1.983s)
[690.898343] Starting dynamic subtest: vecs0
[692.874368] Dynamic subtest vecs0: SUCCESS (1.983s)
[692.883447] Starting dynamic subtest: ccs0
[694.919789] Dynamic subtest ccs0: SUCCESS (2.043s)
[694.921494] Subtest gt-engine-hang: SUCCESS (11.760s)
[694.994955] [109/130] (334s left) kms_pipe_stress (stress-xrgb8888-untiled)
[695.096326] Starting subtest: stress-xrgb8888-untiled
[701.187381] Subtest stress-xrgb8888-untiled: SUCCESS (6.091s)
[701.233429] [110/130] (328s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[701.326409] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[705.891626] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.564s)
[706.018756] [111/130] (323s left) kms_chamelium_frames (hdmi-frame-dump)
[706.402158] Subtest hdmi-frame-dump: SKIP (0.000s)
[707.211771] [112/130] (322s left) kms_busy (extended-pageflip-hang-newfb)
[707.310818] Starting subtest: extended-pageflip-hang-newfb
[707.313202] Starting dynamic subtest: pipe-A
[733.694445] Dynamic subtest pipe-A: SUCCESS (26.381s)
[733.703753] Starting dynamic subtest: pipe-D
[758.709608] Dynamic subtest pipe-D: SUCCESS (25.011s)
[758.710538] Subtest extended-pageflip-hang-newfb: SUCCESS (51.397s)
[759.486652] [113/130] (270s left) kms_psr (psr2-suspend)
[759.582212] Starting subtest: psr2-suspend
[759.583079] Starting dynamic subtest: eDP-1
[777.136077] Dynamic subtest eDP-1: SUCCESS (2.800s)
[777.137191] Subtest psr2-suspend: SUCCESS (2.801s)
[777.924211] [114/130] (266s left) gem_render_copy_redux (flink)
[777.980100] Starting subtest: flink
[778.903417] Subtest flink: SUCCESS (0.922s)
[779.015981] [115/130] (265s left) kms_vblank (wait-forked-hang)
[779.115808] Starting subtest: wait-forked-hang
[779.117861] Starting dynamic subtest: pipe-A-eDP-1
[805.507726] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.373s)
[805.520590] Starting dynamic subtest: pipe-D-eDP-1
[820.415020] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.904s)
[820.416454] Subtest wait-forked-hang: SUCCESS (41.281s)
[821.287226] [116/130] (223s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[821.375015] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[821.375872] Starting dynamic subtest: pipe-A
[821.391699] Dynamic subtest pipe-A: SKIP (0.014s)
[821.407400] Starting dynamic subtest: pipe-B
[821.414169] Dynamic subtest pipe-B: SKIP (0.022s)
[821.422535] Starting dynamic subtest: pipe-C
[821.436364] Dynamic subtest pipe-C: SKIP (0.022s)
[821.444431] Starting dynamic subtest: pipe-D
[821.459914] Dynamic subtest pipe-D: SKIP (0.023s)
[821.461691] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.083s)
[821.551828] [117/130] (223s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[821.642176] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[821.643344] Starting dynamic subtest: pipe-A-eDP-1
[821.653716] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[821.662906] Starting dynamic subtest: pipe-B-eDP-1
[821.672935] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[821.681898] Starting dynamic subtest: pipe-C-eDP-1
[821.690400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[821.698185] Starting dynamic subtest: pipe-D-eDP-1
[821.707066] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[821.708776] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[823.839323] [118/130] (220s left) kms_chamelium_color (ctm-negative)
[823.942764] Subtest ctm-negative: SKIP (0.000s)
[823.981882] [119/130] (220s left) perf (gen12-invalid-class-instance)
[824.085144] Starting subtest: gen12-invalid-class-instance
[824.102713] Subtest gen12-invalid-class-instance: SUCCESS (0.018s)
[824.140338] [120/130] (220s left) kms_psr (psr2-primary-blt)
[824.231546] Starting subtest: psr2-primary-blt
[824.232482] Starting dynamic subtest: eDP-1
[825.930737] Dynamic subtest eDP-1: SUCCESS (1.700s)
[825.931627] Subtest psr2-primary-blt: SUCCESS (1.701s)
[826.805671] [121/130] (217s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[826.908575] Starting subtest: fbc-psr2-sprite-plane-onoff
[826.909720] Starting dynamic subtest: eDP-1
[826.911824] Dynamic subtest eDP-1: SKIP (0.000s)
[826.913753] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[826.986338] [122/130] (217s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[827.089200] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[827.091067] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[827.209445] [123/130] (217s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[832.263412] Starting subtest: pr-cursor-plane-update-sf
[832.265184] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[833.099779] [124/130] (211s left) gem_userptr_blits (sync-unmap-cycles)
[833.156849] Starting subtest: sync-unmap-cycles
[838.536812] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[838.683335] [125/130] (206s left) kms_flip (flip-vs-absolute-wf_vblank)
[838.782603] Starting subtest: flip-vs-absolute-wf_vblank
[838.784743] Starting dynamic subtest: A-eDP1
[847.745607] Dynamic subtest A-eDP1: SUCCESS (8.959s)
[847.756042] Starting dynamic subtest: B-eDP1
[856.678206] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[856.688314] Starting dynamic subtest: C-eDP1
[865.589953] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[865.601531] Starting dynamic subtest: D-eDP1
[874.509546] Dynamic subtest D-eDP1: SUCCESS (8.917s)
[874.513263] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.725s)
[875.718291] [126/130] (169s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[875.813873] Starting subtest: psr-rgb565-draw-pwrite
[880.788214] Subtest psr-rgb565-draw-pwrite: SUCCESS (4.976s)
[880.882280] [127/130] (164s left) gem_exec_reloc (basic-gtt-read)
[880.938583] Subtest basic-gtt-read: SKIP (0.000s)
[881.015070] [128/130] (163s left) gem_exec_endless (dispatch)
[881.087761] Starting subtest: dispatch
[881.088919] Starting dynamic subtest: rcs0
[881.092892] Dynamic subtest rcs0: SUCCESS (0.005s)
[881.102342] Starting dynamic subtest: bcs0
[881.104258] Dynamic subtest bcs0: SUCCESS (0.004s)
[881.113036] Starting dynamic subtest: vcs0
[881.115103] Dynamic subtest vcs0: SUCCESS (0.004s)
[881.125585] Starting dynamic subtest: vcs1
[881.127349] Dynamic subtest vcs1: SUCCESS (0.006s)
[881.135294] Starting dynamic subtest: vecs0
[881.137154] Dynamic subtest vecs0: SUCCESS (0.005s)
[881.145088] Starting dynamic subtest: ccs0
[881.146810] Dynamic subtest ccs0: SUCCESS (0.004s)
[881.147647] Subtest dispatch: SUCCESS (0.031s)
[882.733164] [129/130] (162s left) core_setmaster (master-drop-set-shared-fd)
[884.876941] Starting subtest: master-drop-set-shared-fd
[884.887695] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[884.915686] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.amdgpu: true
[884.916398] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.xe: true
[884.918101] [130/130] (160s left) syncobj_wait (invalid-signal-one-illegal-handle)
[884.968320] Starting subtest: invalid-signal-one-illegal-handle
[884.969281] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[885.071142] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: gem_fenced_exec_thrash
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: syncobj_basic
results: parsing output: 7/ for test: i915_pm_rpm
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_atomic_transition
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_atomic_interruptible
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: kms_lease
results: parsing output: 19/ for test: gem_ctx_isolation
results: parsing output: 20/ for test: gem_flink_race
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: gen7_exec_parse
results: parsing output: 23/ for test: sw_sync
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_pipe_b_c_ivb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: intel_hwmon
results: parsing output: 32/ for test: core_auth
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_vblank
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: dmabuf_sync_file
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 44/ for test: gem_readwrite
results: parsing output: 45/ for test: gem_pread
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_selftest
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_parallel
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: kms_pm_lpsp
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_pm_backlight
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_exec_store
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cdclk
results: parsing output: 81/ for test: kms_dp_link_training
results: parsing output: 82/ for test: api_intel_allocator
results: parsing output: 83/ for test: gem_cs_tlb
results: parsing output: 84/ for test: syncobj_basic
results: parsing output: 85/ for test: prime_busy
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_ccs
results: parsing output: 89/ for test: gem_partial_pwrite_pread
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: gem_exec_suspend
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_color
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap
results: parsing output: 102/ for test: dumb_buffer
results: parsing output: 103/ for test: kms_rmfb
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: i915_hangman
results: parsing output: 108/ for test: kms_pipe_stress
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_chamelium_frames
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_render_copy_redux
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_chamelium_color
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: gem_exec_endless
results: parsing output: 128/ for test: core_setmaster
results: parsing output: 129/ for test: syncobj_wait
Done.