[42.378552] Initializing watchdogs
[42.378602]   /dev/watchdog0
[42.385213] [001/130] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[42.425220] Starting subtest: multi-wait-for-submit-unsubmitted
[42.527257] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[42.599336] [002/130] (960s left) i915_pm_rpm (gem-idle)
[43.030904] Starting subtest: gem-idle
[48.266073] Subtest gem-idle: SUCCESS (5.236s)
[48.419985] [003/130] (954s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[48.527059] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[48.528565] Starting dynamic subtest: pipe-A-HDMI-A-2
[48.535283] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[48.539088] Starting dynamic subtest: pipe-B-HDMI-A-2
[48.545896] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[48.547270] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.002s)
[48.733782] [004/130] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[48.840814] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[48.842168] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[48.961964] [005/130] (954s left) gem_lmem_swapping (verify)
[49.011626] Subtest verify: SKIP (0.000s)
[49.037840] [006/130] (953s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[49.142107] Starting subtest: short-flip-before-cursor-atomic-transitions
[50.189304] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.047s)
[50.315409] [007/130] (952s left) i915_query (query-topology-kernel-writes)
[50.356446] Starting subtest: query-topology-kernel-writes
[50.357139] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[50.425777] [008/130] (952s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[50.525489] Starting subtest: fbc-rgb101010-draw-mmap-wc
[53.250302] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.725s)
[53.368544] [009/130] (949s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[53.469155] Starting subtest: cursorA-vs-flipB-atomic-transitions
[53.470568] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[53.542327] [010/130] (949s left) perf (gen12-oa-tlb-invalidate)
[53.692750] Starting subtest: gen12-oa-tlb-invalidate
[53.693463] Starting dynamic subtest: 0-rcs0
[63.742669] Dynamic subtest 0-rcs0: SUCCESS (10.050s)
[63.743466] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.050s)
[63.774680] [011/130] (939s left) kms_pm_rpm (cursor-dpms)
[65.238266] Starting subtest: cursor-dpms
[66.828720] Subtest cursor-dpms: SUCCESS (1.591s)
[67.010618] [012/130] (936s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[67.051363] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[67.052063] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[67.121394] [013/130] (936s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[67.227572] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[69.525990] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.299s)
[69.682336] [014/130] (933s left) gem_exec_flush (basic-uc-set-default)
[69.731693] Starting subtest: basic-uc-set-default
[75.225501] Subtest basic-uc-set-default: SUCCESS (5.494s)
[75.424410] [015/130] (927s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[75.543553] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[75.544888] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[75.646359] [016/130] (927s left) sysfs_heartbeat_interval (precise)
[75.692630] Starting subtest: precise
[75.693321] Starting dynamic subtest: vecs0
[77.321552] Dynamic subtest vecs0: SUCCESS (1.628s)
[77.330271] Starting dynamic subtest: vcs0
[78.887972] Dynamic subtest vcs0: SUCCESS (1.566s)
[78.894116] Starting dynamic subtest: bcs0
[81.181477] Dynamic subtest bcs0: SUCCESS (2.292s)
[81.188793] Starting dynamic subtest: rcs0
[82.740027] Dynamic subtest rcs0: SUCCESS (1.559s)
[82.740786] Subtest precise: SUCCESS (7.047s)
[82.812464] [017/130] (920s left) kms_properties (connector-properties-legacy)
[82.910898] Starting subtest: connector-properties-legacy
[82.911615] Starting dynamic subtest: pipe-A-HDMI-A-2
[83.619535] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.707s)
[83.628317] Starting dynamic subtest: pipe-None-HDMI-A-1
[83.629757] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.008s)
[83.634337] Starting dynamic subtest: pipe-None-DP-1
[83.635733] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[83.640065] Starting dynamic subtest: pipe-None-HDMI-A-3
[83.641454] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.001s)
[83.642142] Subtest connector-properties-legacy: SUCCESS (0.720s)
[83.771020] [018/130] (919s left) prime_mmap (test_map_unmap)
[83.815834] Starting subtest: test_map_unmap
[83.816532] Starting dynamic subtest: test_map_unmap-smem
[83.902668] Dynamic subtest test_map_unmap-smem: SUCCESS (0.087s)
[83.903422] Subtest test_map_unmap: SUCCESS (0.087s)
[84.020375] [019/130] (919s left) gem_pread (snoop)
[84.061052] Subtest snoop: SKIP (0.000s)
[84.094240] [020/130] (919s left) gem_softpin (evict-single-offset)
[84.130922] Starting subtest: evict-single-offset
[108.357061] Subtest evict-single-offset: SUCCESS (24.225s)
[108.441824] [021/130] (894s left) kms_flip (dpms-off-confusion)
[108.557611] Starting subtest: dpms-off-confusion
[108.558307] Starting dynamic subtest: A-HDMI-A2
[123.765934] Dynamic subtest A-HDMI-A2: SUCCESS (15.207s)
[123.773032] Starting dynamic subtest: B-HDMI-A2
[138.906204] Dynamic subtest B-HDMI-A2: SUCCESS (15.140s)
[138.906917] Subtest dpms-off-confusion: SUCCESS (30.349s)
[139.072388] [022/130] (864s left) gem_pxp (fail-invalid-protected-context)
[259.334950] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[261.621738] Closing watchdogs
[261.625172] Initializing watchdogs
[261.625221]   /dev/watchdog0
[261.631269] [023/130] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[261.727762] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[261.729097] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[261.815651] [024/130] (741s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[261.923069] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[261.924460] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[261.997968] [025/130] (741s left) prime_vgem (fence-flip-hang)
[262.092380] Subtest fence-flip-hang: SKIP (0.000s)
[262.197551] [026/130] (741s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[262.304849] Starting subtest: x-tiled-16bpp-rotate-180
[263.891841] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.586s)
[264.067710] [027/130] (739s left) syncobj_timeline (single-wait-signaled)
[264.105649] Starting subtest: single-wait-signaled
[264.106410] Subtest single-wait-signaled: SUCCESS (0.000s)
[264.189741] [028/130] (739s left) kms_content_protection (dp-mst-lic-type-1)
[264.290113] Starting subtest: dp-mst-lic-type-1
[264.291501] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[264.397322] [029/130] (739s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[264.501154] Starting subtest: cursor-vs-flip-atomic
[293.097364] Subtest cursor-vs-flip-atomic: SUCCESS (28.595s)
[293.258095] [030/130] (710s left) kms_chamelium_edid (hdmi-mode-timings)
[293.401427] Subtest hdmi-mode-timings: SKIP (0.000s)
[293.450571] [031/130] (710s left) kms_plane_scaling (invalid-parameters)
[293.552155] Starting subtest: invalid-parameters
[293.552839] Starting dynamic subtest: less-than-1-height-src
[293.559405] Dynamic subtest less-than-1-height-src: SUCCESS (0.007s)
[293.564559] Starting dynamic subtest: less-than-1-width-src
[293.567151] Dynamic subtest less-than-1-width-src: SUCCESS (0.007s)
[293.567837] Subtest invalid-parameters: SUCCESS (0.015s)
[293.683322] [032/130] (709s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[293.785760] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[293.813698] [033/130] (709s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[293.917759] Starting subtest: psr-rgb101010-draw-mmap-wc
[293.919088] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[294.036926] [034/130] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[294.138643] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[294.139957] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[294.233016] [035/130] (709s left) gen9_exec_parse (valid-registers)
[294.277350] Subtest valid-registers: SKIP (0.000s)
[294.304787] [036/130] (709s left) i915_query (query-regions-garbage-items)
[294.340760] Starting subtest: query-regions-garbage-items
[294.341435] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[294.415928] [037/130] (709s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[294.523084] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[294.523786] Starting dynamic subtest: pipe-A-valid-mode
[294.582109] Dynamic subtest pipe-A-valid-mode: SKIP (0.058s)
[294.583512] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.058s)
[294.735694] [038/130] (708s left) kms_cursor_crc (cursor-sliding-32x10)
[294.844692] Starting subtest: cursor-sliding-32x10
[294.875298] Subtest cursor-sliding-32x10: SKIP (0.029s)
[294.994399] [039/130] (708s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[295.091068] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[295.091815] Starting dynamic subtest: pipe-A-valid-mode
[295.143279] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[295.144819] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.051s)
[295.250533] [040/130] (708s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[295.351526] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[295.352917] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.438850] [041/130] (708s left) gem_close_race (multigpu-basic-process)
[295.485520] Starting subtest: multigpu-basic-process
[295.486907] Subtest multigpu-basic-process: SKIP (0.000s)
[295.669423] [042/130] (708s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[295.773768] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[296.908994] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.134s)
[297.085426] [043/130] (706s left) gem_eio (in-flight-contexts-immediate)
[297.130781] Starting subtest: in-flight-contexts-immediate
[308.812791] Subtest in-flight-contexts-immediate: SUCCESS (11.681s)
[308.943887] [044/130] (694s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[309.047095] Starting subtest: cursorA-vs-flipB-varying-size
[309.048487] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[309.120218] [045/130] (694s left) kms_chamelium_audio (dp-audio-edid)
[309.267342] Subtest dp-audio-edid: SKIP (0.000s)
[309.327380] [046/130] (694s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[309.440404] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[309.803793] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.363s)
[310.007983] [047/130] (693s left) gem_exec_balancer (bonded-semaphore)
[310.056093] Starting subtest: bonded-semaphore
[310.996600] Subtest bonded-semaphore: SUCCESS (0.940s)
[312.160844] [048/130] (691s left) kms_cursor_legacy (torture-bo)
[312.256093] Starting subtest: torture-bo
[312.256848] Starting dynamic subtest: pipe-A
[317.797684] Dynamic subtest pipe-A: SUCCESS (5.540s)
[317.803710] Starting dynamic subtest: pipe-B
[323.412989] Dynamic subtest pipe-B: SUCCESS (5.615s)
[323.418998] Starting dynamic subtest: all-pipes
[329.408139] Dynamic subtest all-pipes: SUCCESS (5.995s)
[329.408878] Subtest torture-bo: SUCCESS (17.151s)
[329.489529] [049/130] (674s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[329.594176] Starting subtest: y-tiled-8bpp-rotate-0
[330.980254] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.385s)
[331.137701] [050/130] (672s left) kms_universal_plane (universal-plane-functional)
[331.234979] Starting subtest: universal-plane-functional
[331.235763] Starting dynamic subtest: pipe-A-HDMI-A-2
[333.417587] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.181s)
[333.423305] Starting dynamic subtest: pipe-B-HDMI-A-2
[335.427591] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.009s)
[335.428291] Subtest universal-plane-functional: SUCCESS (4.192s)
[335.535638] [051/130] (668s left) gem_media_fill (media-fill)
[335.579302] Starting subtest: media-fill
[335.580037] Starting dynamic subtest: smem
[335.582225] Dynamic subtest smem: SUCCESS (0.003s)
[335.582923] Subtest media-fill: SUCCESS (0.003s)
[335.813138] [052/130] (668s left) syncobj_timeline (device-signal-unordered)
[335.847330] Starting subtest: device-signal-unordered
[335.848058] Subtest device-signal-unordered: SUCCESS (0.000s)
[335.931476] [053/130] (668s left) kms_async_flips (async-flip-with-page-flip-events)
[336.031094] Starting subtest: async-flip-with-page-flip-events
[336.186693] Starting dynamic subtest: pipe-A-HDMI-A-2-y-rc-ccs
[336.333792] Dynamic subtest pipe-A-HDMI-A-2-y-rc-ccs: SKIP (0.146s)
[336.339192] Starting dynamic subtest: pipe-A-HDMI-A-2-y-rc-ccs-cc
[336.548476] Dynamic subtest pipe-A-HDMI-A-2-y-rc-ccs-cc: SKIP (0.214s)
[336.553838] Starting dynamic subtest: pipe-A-HDMI-A-2-y
[338.667887] Dynamic subtest pipe-A-HDMI-A-2-y: SUCCESS (2.119s)
[338.676446] Starting dynamic subtest: pipe-A-HDMI-A-2-x
[340.735348] Dynamic subtest pipe-A-HDMI-A-2-x: SUCCESS (2.067s)
[340.740868] Starting dynamic subtest: pipe-A-HDMI-A-2-linear
[342.785520] Dynamic subtest pipe-A-HDMI-A-2-linear: SUCCESS (2.049s)
[342.951793] Starting dynamic subtest: pipe-B-HDMI-A-2-y-rc-ccs
[343.090472] Dynamic subtest pipe-B-HDMI-A-2-y-rc-ccs: SKIP (0.143s)
[343.095837] Starting dynamic subtest: pipe-B-HDMI-A-2-y-rc-ccs-cc
[343.202369] Dynamic subtest pipe-B-HDMI-A-2-y-rc-ccs-cc: SKIP (0.112s)
[343.207882] Starting dynamic subtest: pipe-B-HDMI-A-2-y
[345.311449] Dynamic subtest pipe-B-HDMI-A-2-y: SUCCESS (2.109s)
[345.327143] Starting dynamic subtest: pipe-B-HDMI-A-2-x
[347.359774] Dynamic subtest pipe-B-HDMI-A-2-x: SUCCESS (2.048s)
[347.365616] Starting dynamic subtest: pipe-B-HDMI-A-2-linear
[349.389912] Dynamic subtest pipe-B-HDMI-A-2-linear: SUCCESS (2.030s)
[349.390818] Subtest async-flip-with-page-flip-events: SUCCESS (13.358s)
[349.652753] [054/130] (654s left) kms_content_protection (atomic)
[349.752218] Starting subtest: atomic
[349.898897] Subtest atomic: SKIP (0.142s)
[350.078637] [055/130] (654s left) kms_setmode (basic-clone-single-crtc)
[350.114224] Starting subtest: basic-clone-single-crtc
[350.116295] Subtest basic-clone-single-crtc: SKIP (0.000s)
[350.192461] [056/130] (653s left) i915_pm_rpm (debugfs-forcewake-user)
[351.605909] Starting subtest: debugfs-forcewake-user
[362.020765] Subtest debugfs-forcewake-user: SUCCESS (10.414s)
[362.167693] [057/130] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[362.266862] Starting subtest: psr-1p-primscrn-spr-indfb-move
[362.268179] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[362.379282] [058/130] (641s left) gem_exec_create (basic)
[362.425980] Starting subtest: basic
[362.426803] Starting dynamic subtest: smem
[364.483361] Dynamic subtest smem: SUCCESS (2.057s)
[364.484133] Subtest basic: SUCCESS (2.058s)
[364.662682] [059/130] (639s left) kms_invalid_mode (zero-clock)
[364.763607] Starting subtest: zero-clock
[364.764304] Starting dynamic subtest: pipe-A-HDMI-A-2
[364.819860] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.055s)
[364.831156] Starting dynamic subtest: pipe-B-HDMI-A-2
[364.831938] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[364.832702] Subtest zero-clock: SUCCESS (0.059s)
[364.969068] [060/130] (639s left) kms_pipe_crc_basic (nonblocking-crc)
[365.064112] Starting subtest: nonblocking-crc
[365.065802] Starting dynamic subtest: pipe-A-HDMI-A-2
[365.699530] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.634s)
[365.706288] Starting dynamic subtest: pipe-B-HDMI-A-2
[366.241437] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.541s)
[366.242225] Subtest nonblocking-crc: SUCCESS (1.177s)
[366.349470] [061/130] (637s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[366.452896] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[366.454257] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[366.539588] [062/130] (637s left) kms_psr (psr-primary-mmap-gtt)
[366.640596] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[366.666470] [063/130] (637s left) gem_partial_pwrite_pread (reads-display)
[366.707695] Subtest reads-display: SKIP (0.000s)
[366.772364] [064/130] (637s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[366.815818] Starting subtest: invalid-multi-wait-unsubmitted
[366.816521] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[366.899135] [065/130] (637s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[366.999300] Starting subtest: 2x-plain-flip-ts-check-interruptible
[367.000745] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.001s)
[367.128015] [066/130] (637s left) kms_chamelium_hpd (dp-hpd-storm)
[367.273120] Subtest dp-hpd-storm: SKIP (0.000s)
[367.325902] [067/130] (637s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[367.425906] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[367.427263] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[367.540615] [068/130] (636s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[367.641129] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[367.668717] [069/130] (636s left) kms_plane_scaling (planes-downscale-factor-0-75)
[367.771124] Starting subtest: planes-downscale-factor-0-75
[367.771836] Starting dynamic subtest: pipe-A
[367.867379] Dynamic subtest pipe-A: SUCCESS (0.095s)
[367.877466] Starting dynamic subtest: pipe-B
[368.004917] Dynamic subtest pipe-B: SUCCESS (0.136s)
[368.006277] Subtest planes-downscale-factor-0-75: SUCCESS (0.234s)
[368.173999] [070/130] (636s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[368.270869] Starting subtest: cursor-rapid-movement-256x256
[368.273533] Starting dynamic subtest: pipe-A-HDMI-A-2
[368.664510] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.389s)
[368.691871] Starting dynamic subtest: pipe-B-HDMI-A-2
[368.958026] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.272s)
[368.958775] Subtest cursor-rapid-movement-256x256: SUCCESS (0.687s)
[369.122739] [071/130] (635s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[369.223126] Starting subtest: multiplane-rotation-cropping-bottom
[391.141105] Subtest multiplane-rotation-cropping-bottom: SUCCESS (21.917s)
[391.279710] [072/130] (613s left) gen9_exec_parse (allowed-all)
[391.322641] Subtest allowed-all: SKIP (0.000s)
[391.337728] [073/130] (613s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[391.456764] Starting subtest: 4-tiled-16bpp-rotate-180
[391.458140] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[391.553171] [074/130] (613s left) gem_mmap_offset (bad-flags)
[391.594054] Starting subtest: bad-flags
[391.594773] Subtest bad-flags: SUCCESS (0.000s)
[391.704213] [075/130] (612s left) prime_self_import (export-vs-gem_close-race)
[391.741682] Starting subtest: export-vs-gem_close-race
[396.782297] Subtest export-vs-gem_close-race: SUCCESS (5.041s)
[396.876950] [076/130] (607s left) gem_eio (in-flight-internal-1us)
[396.961689] Starting subtest: in-flight-internal-1us
[397.225745] Subtest in-flight-internal-1us: SUCCESS (0.264s)
[397.419667] [077/130] (607s left) gem_ctx_persistence (engines-cleanup)
[397.461101] Starting subtest: engines-cleanup
[397.461885] Starting dynamic subtest: rcs0
[397.509247] Dynamic subtest rcs0: SUCCESS (0.047s)
[397.531179] Starting dynamic subtest: bcs0
[397.577905] Dynamic subtest bcs0: SUCCESS (0.066s)
[397.599483] Starting dynamic subtest: vcs0
[397.638529] Dynamic subtest vcs0: SUCCESS (0.058s)
[397.649948] Starting dynamic subtest: vecs0
[397.692972] Dynamic subtest vecs0: SUCCESS (0.052s)
[397.694572] Subtest engines-cleanup: SUCCESS (0.233s)
[397.775560] [078/130] (606s left) gem_exec_schedule (implicit-read-write)
[397.822553] Starting subtest: implicit-read-write
[397.823319] Starting dynamic subtest: rcs0
[397.870753] Dynamic subtest rcs0: SUCCESS (0.047s)
[397.881495] Starting dynamic subtest: bcs0
[397.920894] Dynamic subtest bcs0: SUCCESS (0.047s)
[397.932140] Starting dynamic subtest: vcs0
[397.972101] Dynamic subtest vcs0: SUCCESS (0.049s)
[397.983751] Starting dynamic subtest: vecs0
[398.027579] Dynamic subtest vecs0: SUCCESS (0.053s)
[398.028613] Subtest implicit-read-write: SUCCESS (0.205s)
[398.340010] [079/130] (606s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[398.439888] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[398.441212] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[398.574508] [080/130] (606s left) kms_flip (bo-too-big)
[398.671528] Starting subtest: bo-too-big
[398.673316] Starting dynamic subtest: A-HDMI-A2
[399.002369] Dynamic subtest A-HDMI-A2: SUCCESS (0.329s)
[399.021780] Starting dynamic subtest: B-HDMI-A2
[399.308896] Dynamic subtest B-HDMI-A2: SUCCESS (0.303s)
[399.313220] Subtest bo-too-big: SUCCESS (0.639s)
[399.458904] [081/130] (605s left) syncobj_wait (single-wait-all-submitted)
[399.494431] Starting subtest: single-wait-all-submitted
[399.597964] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[399.673455] [082/130] (605s left) gem_exec_fence (syncobj-timeline-chain-engines)
[400.148950] Starting subtest: syncobj-timeline-chain-engines
[400.180828] Subtest syncobj-timeline-chain-engines: SUCCESS (0.033s)
[400.362764] [083/130] (604s left) gem_create (create-ext-placement-sanity-check)
[400.518111] Starting subtest: create-ext-placement-sanity-check
[400.525572] Subtest create-ext-placement-sanity-check: SUCCESS (0.006s)
[400.655527] [084/130] (604s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[400.757052] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[400.758419] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[400.881759] [085/130] (603s left) kms_plane_multiple (tiling-x)
[400.980190] Starting subtest: tiling-x
[400.981985] Starting dynamic subtest: pipe-A-HDMI-A-2
[401.580852] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.599s)
[401.590656] Starting dynamic subtest: pipe-B-HDMI-A-2
[402.119119] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.536s)
[402.119811] Subtest tiling-x: SUCCESS (1.138s)
[402.288629] [086/130] (602s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[402.387863] Starting subtest: fbcpsr-indfb-scaledprimary
[402.389334] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[402.499350] [087/130] (602s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[402.553935] Starting subtest: etime-single-wait-for-submit-submitted
[402.655162] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s)
[402.745558] [088/130] (602s left) gem_softpin (evict-snoop-interruptible)
[402.787693] Starting subtest: evict-snoop-interruptible
[402.789131] Subtest evict-snoop-interruptible: SKIP (0.000s)
[402.875868] [089/130] (602s left) gem_exec_schedule (u-submit-late-slice)
[402.921843] Starting subtest: u-submit-late-slice
[402.922664] Starting dynamic subtest: rcs0
[402.942185] Dynamic subtest rcs0: SUCCESS (0.020s)
[402.948150] Starting dynamic subtest: bcs0
[402.960163] Dynamic subtest bcs0: SUCCESS (0.017s)
[402.966006] Starting dynamic subtest: vcs0
[402.980235] Dynamic subtest vcs0: SUCCESS (0.019s)
[402.986256] Starting dynamic subtest: vecs0
[402.997288] Dynamic subtest vecs0: SUCCESS (0.016s)
[402.998126] Subtest u-submit-late-slice: SUCCESS (0.076s)
[403.305773] [090/130] (601s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[403.398267] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[403.398974] Starting dynamic subtest: pipe-A-HDMI-A-2
[403.405813] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[403.411647] Starting dynamic subtest: pipe-B-HDMI-A-2
[403.418473] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[403.419813] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.002s)
[403.605266] [091/130] (601s left) perf_pmu (most-busy-idle-check-all)
[403.645240] Starting subtest: most-busy-idle-check-all
[403.645965] Starting dynamic subtest: rcs0
[404.291993] Dynamic subtest rcs0: FAIL (0.630s)
[404.298108] Starting dynamic subtest: bcs0
[404.892599] Dynamic subtest bcs0: SUCCESS (0.615s)
[404.904784] Starting dynamic subtest: vcs0
[405.514617] Dynamic subtest vcs0: SUCCESS (0.619s)
[405.527101] Starting dynamic subtest: vecs0
[406.140573] Dynamic subtest vecs0: SUCCESS (0.623s)
[406.141819] Subtest most-busy-idle-check-all: FAIL (2.496s)
[406.215897] [092/130] (598s left) gem_exec_balancer (parallel-out-fence)
[407.346042] Subtest parallel-out-fence: SKIP (0.000s)
[407.431438] [093/130] (597s left) gem_exec_fence (basic-await)
[407.607045] Starting subtest: basic-await
[407.607976] Starting dynamic subtest: rcs0
[407.683342] Dynamic subtest rcs0: SUCCESS (0.075s)
[407.702659] Starting dynamic subtest: bcs0
[407.769729] Dynamic subtest bcs0: SUCCESS (0.083s)
[407.789470] Starting dynamic subtest: vcs0
[407.856726] Dynamic subtest vcs0: SUCCESS (0.084s)
[407.875014] Starting dynamic subtest: vecs0
[407.951186] Dynamic subtest vecs0: SUCCESS (0.086s)
[407.953962] Subtest basic-await: SUCCESS (0.340s)
[408.418109] [094/130] (596s left) syncobj_basic (bad-create-flags)
[408.453847] Starting subtest: bad-create-flags
[408.454565] Subtest bad-create-flags: SUCCESS (0.000s)
[408.536840] [095/130] (596s left) kms_pm_rpm (pm-caching)
[409.950721] Starting subtest: pm-caching
[411.266505] Subtest pm-caching: SUCCESS (1.316s)
[411.435243] [096/130] (593s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[411.531942] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[411.533304] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[411.665214] [097/130] (593s left) gem_flink_basic (double-flink)
[411.701671] Starting subtest: double-flink
[411.702397] Subtest double-flink: SUCCESS (0.000s)
[411.795781] [098/130] (593s left) prime_vgem (busy)
[411.862379] Starting subtest: busy
[411.863162] Starting dynamic subtest: rcs0
[411.902252] Dynamic subtest rcs0: SUCCESS (0.039s)
[411.917922] Starting dynamic subtest: bcs0
[411.948826] Dynamic subtest bcs0: SUCCESS (0.044s)
[411.967771] Starting dynamic subtest: vcs0
[411.969956] Dynamic subtest vcs0: SUCCESS (0.018s)
[411.976306] Starting dynamic subtest: vecs0
[411.988326] Dynamic subtest vecs0: SUCCESS (0.019s)
[411.989087] Subtest busy: SUCCESS (0.127s)
[412.119140] [099/130] (593s left) prime_self_import (basic-with_one_bo)
[412.153302] Starting subtest: basic-with_one_bo
[412.154759] Subtest basic-with_one_bo: SUCCESS (0.002s)
[412.220148] [100/130] (593s left) kms_vrr (flip-basic)
[412.317203] Starting subtest: flip-basic
[412.319269] Subtest flip-basic: SKIP (0.000s)
[412.394535] [101/130] (592s left) kms_draw_crc (draw-method-mmap-cpu)
[412.493987] Starting subtest: draw-method-mmap-cpu
[412.494747] Starting dynamic subtest: xrgb8888-untiled
[412.805833] Dynamic subtest xrgb8888-untiled: SUCCESS (0.311s)
[412.827156] Starting dynamic subtest: rgb565-untiled
[413.146800] Dynamic subtest rgb565-untiled: SUCCESS (0.337s)
[413.166902] Starting dynamic subtest: xrgb2101010-untiled
[413.450497] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.301s)
[413.470342] Starting dynamic subtest: xrgb8888-xtiled
[413.621356] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.168s)
[413.642415] Starting dynamic subtest: rgb565-xtiled
[413.792494] Dynamic subtest rgb565-xtiled: SUCCESS (0.167s)
[413.813567] Starting dynamic subtest: xrgb2101010-xtiled
[413.943880] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.147s)
[413.957499] Starting dynamic subtest: xrgb8888-ytiled
[414.114728] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.168s)
[414.135633] Starting dynamic subtest: rgb565-ytiled
[414.285246] Dynamic subtest rgb565-ytiled: SUCCESS (0.168s)
[414.295484] Starting dynamic subtest: xrgb2101010-ytiled
[414.437248] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.149s)
[414.438542] Subtest draw-method-mmap-cpu: SUCCESS (1.945s)
[414.567592] [102/130] (590s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[414.672101] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[414.673478] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[414.775423] [103/130] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[414.872981] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[414.874324] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[414.976590] [104/130] (590s left) syncobj_wait (wait-for-submit-snapshot)
[415.018193] Starting subtest: wait-for-submit-snapshot
[415.101443] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[415.183916] [105/130] (590s left) gem_exec_whisper (basic-forked)
[415.226791] Starting subtest: basic-forked
[416.817241] Subtest basic-forked: SUCCESS (1.590s)
[417.027682] [106/130] (588s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[417.143980] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[417.145362] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[417.261458] [107/130] (588s left) gem_ctx_persistence (legacy-engines-hang)
[417.297450] Starting subtest: legacy-engines-hang
[417.298176] Starting dynamic subtest: render
[417.351044] Dynamic subtest render: SUCCESS (0.052s)
[417.374475] Starting dynamic subtest: bsd
[417.418877] Dynamic subtest bsd: SUCCESS (0.064s)
[417.441137] Starting dynamic subtest: blt
[417.480874] Dynamic subtest blt: SUCCESS (0.059s)
[417.502806] Starting dynamic subtest: vebox
[417.553866] Dynamic subtest vebox: SUCCESS (0.070s)
[417.555256] Subtest legacy-engines-hang: SUCCESS (0.257s)
[417.641444] [108/130] (587s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[417.685227] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[417.685983] Starting dynamic subtest: smem
[417.839813] Dynamic subtest smem: SUCCESS (0.154s)
[417.840549] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.155s)
[418.040272] [109/130] (587s left) api_intel_bb (add-remove-objects)
[418.076277] Starting subtest: add-remove-objects
[418.079789] Subtest add-remove-objects: SUCCESS (0.004s)
[418.210151] [110/130] (587s left) kms_psr (pr-primary-page-flip)
[418.308755] Subtest pr-primary-page-flip: SKIP (0.000s)
[418.337581] [111/130] (587s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[418.433359] Starting subtest: cursorB-vs-flipA-varying-size
[418.435792] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[418.510920] [112/130] (587s left) kms_lease (lease-get)
[418.608169] Starting subtest: lease-get
[418.609981] Starting dynamic subtest: pipe-A-HDMI-A-2
[418.610718] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.000s)
[418.617246] Starting dynamic subtest: pipe-B-HDMI-A-2
[418.617962] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[418.618667] Subtest lease-get: SUCCESS (0.003s)
[418.702424] [113/130] (586s left) perf (invalid-open-flags)
[418.810799] Starting subtest: invalid-open-flags
[418.811531] Subtest invalid-open-flags: SUCCESS (0.000s)
[418.832939] [114/130] (586s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[418.931197] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[418.932925] Starting dynamic subtest: pipe-A-HDMI-A-2
[418.950060] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[418.956409] Starting dynamic subtest: pipe-B-HDMI-A-2
[418.973733] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[418.975060] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.005s)
[419.145261] [115/130] (586s left) gem_exec_schedule (preempt-engines)
[419.190068] Starting subtest: preempt-engines
[419.190810] Starting dynamic subtest: rcs0
[419.246991] Dynamic subtest rcs0: SUCCESS (0.056s)
[419.253949] Starting dynamic subtest: bcs0
[419.308222] Dynamic subtest bcs0: SUCCESS (0.060s)
[419.315023] Starting dynamic subtest: vcs0
[419.368702] Dynamic subtest vcs0: SUCCESS (0.060s)
[419.375165] Starting dynamic subtest: vecs0
[419.427421] Dynamic subtest vecs0: SUCCESS (0.058s)
[419.428152] Subtest preempt-engines: SUCCESS (0.238s)
[419.744329] [116/130] (585s left) api_intel_bb (reset-flags)
[419.779469] Starting subtest: reset-flags
[419.783222] Subtest reset-flags: SUCCESS (0.005s)
[419.925129] [117/130] (585s left) gem_linear_blits (interruptible)
[420.096933] Starting subtest: interruptible
[422.816549] Subtest interruptible: SUCCESS (2.719s)
[422.919135] [118/130] (582s left) gem_eio (in-flight-internal-10ms)
[422.985037] Starting subtest: in-flight-internal-10ms
[423.248543] Subtest in-flight-internal-10ms: SUCCESS (0.263s)
[423.391109] [119/130] (582s left) drm_fdinfo (context-close-stress)
[423.432856] Starting subtest: context-close-stress
[434.178779] Subtest context-close-stress: SUCCESS (10.746s)
[434.266939] [120/130] (571s left) kms_psr (pr-cursor-mmap-cpu)
[434.363717] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[434.403149] [121/130] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[434.506071] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[434.507432] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[434.609658] [122/130] (571s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[434.708201] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[434.709898] Starting dynamic subtest: pipe-A-HDMI-A-2
[434.716325] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[434.722314] Starting dynamic subtest: pipe-B-HDMI-A-2
[434.728801] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[434.730097] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.003s)
[434.918836] [123/130] (570s left) gem_pxp (verify-pxp-stale-ctx-execution)
[555.719041] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[558.269468] Closing watchdogs
[558.271117] Initializing watchdogs
[558.271172]   /dev/watchdog0
[558.280280] [124/130] (447s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[558.373272] Starting subtest: flip-vs-cursor-crc-legacy
[558.923900] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.550s)
[559.091814] [125/130] (446s left) kms_addfb_basic (bo-too-small)
[559.187142] Starting subtest: bo-too-small
[559.187839] Subtest bo-too-small: SUCCESS (0.000s)
[559.294071] [126/130] (446s left) gem_exec_reloc (basic-gtt-cpu-active)
[559.338498] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[559.420511] [127/130] (446s left) drm_fdinfo (most-busy-idle-check-all)
[559.458436] Starting subtest: most-busy-idle-check-all
[559.459136] Starting dynamic subtest: rcs0
[560.129797] Dynamic subtest rcs0: SUCCESS (0.670s)
[560.142147] Starting dynamic subtest: bcs0
[560.785948] Dynamic subtest bcs0: SUCCESS (0.654s)
[560.797130] Starting dynamic subtest: vcs0
[561.441940] Dynamic subtest vcs0: SUCCESS (0.653s)
[561.454108] Starting dynamic subtest: vecs0
[562.084552] Dynamic subtest vecs0: SUCCESS (0.640s)
[562.085745] Subtest most-busy-idle-check-all: SUCCESS (2.627s)
[562.157999] [128/130] (443s left) i915_query (query-topology-known-pci-ids)
[562.195746] Starting subtest: query-topology-known-pci-ids
[562.197118] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[562.281288] [129/130] (443s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[562.378710] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[562.407839] [130/130] (443s left) kms_psr (fbc-pr-primary-mmap-gtt)
[562.506620] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[562.550269] Closing watchdogs
Done.