[44.855573] Initializing watchdogs
[44.855628]   /dev/watchdog0
[44.861037] [001/130] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[44.905336] Starting subtest: multi-wait-for-submit-unsubmitted
[45.011553] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[45.090120] [002/130] (960s left) i915_pm_rpm (gem-idle)
[45.562849] Starting subtest: gem-idle
[50.791377] Subtest gem-idle: SUCCESS (5.226s)
[50.955513] [003/130] (954s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[51.070841] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[51.071540] Starting dynamic subtest: pipe-A-HDMI-A-1
[51.078111] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[51.081891] Starting dynamic subtest: pipe-B-HDMI-A-1
[51.088499] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[51.089820] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.001s)
[51.279395] [004/130] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[51.400557] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[51.401875] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[51.519581] [005/130] (953s left) gem_lmem_swapping (verify)
[51.570937] Subtest verify: SKIP (0.000s)
[51.590306] [006/130] (953s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[51.707995] Starting subtest: short-flip-before-cursor-atomic-transitions
[52.749340] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.041s)
[52.904051] [007/130] (952s left) i915_query (query-topology-kernel-writes)
[52.949639] Starting subtest: query-topology-kernel-writes
[52.950318] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[53.010727] [008/130] (952s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[53.133304] Starting subtest: fbc-rgb101010-draw-mmap-wc
[55.878384] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.745s)
[56.035241] [009/130] (949s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[56.148943] Starting subtest: cursorA-vs-flipB-atomic-transitions
[56.150295] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[56.224532] [010/130] (949s left) perf (gen12-oa-tlb-invalidate)
[56.387675] Starting subtest: gen12-oa-tlb-invalidate
[56.388396] Starting dynamic subtest: 0-rcs0
[66.417856] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[66.418688] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.030s)
[66.436452] [011/130] (939s left) kms_pm_rpm (cursor-dpms)
[67.877196] Starting subtest: cursor-dpms
[69.646699] Subtest cursor-dpms: SUCCESS (1.770s)
[69.832586] [012/130] (935s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[69.875849] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[69.876565] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[69.957701] [013/130] (935s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[70.077600] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[72.355181] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.279s)
[72.486693] [014/130] (933s left) gem_exec_flush (basic-uc-set-default)
[72.538415] Starting subtest: basic-uc-set-default
[77.985892] Subtest basic-uc-set-default: SUCCESS (5.447s)
[78.202712] [015/130] (927s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[78.353448] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[78.354774] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[78.478161] [016/130] (927s left) sysfs_heartbeat_interval (precise)
[78.524965] Starting subtest: precise
[78.525727] Starting dynamic subtest: vecs0
[80.542668] Dynamic subtest vecs0: SUCCESS (2.017s)
[80.549304] Starting dynamic subtest: vcs0
[82.087164] Dynamic subtest vcs0: SUCCESS (1.542s)
[82.095369] Starting dynamic subtest: bcs0
[83.663027] Dynamic subtest bcs0: SUCCESS (1.577s)
[83.670489] Starting dynamic subtest: rcs0
[85.264718] Dynamic subtest rcs0: SUCCESS (1.599s)
[85.265840] Subtest precise: SUCCESS (6.738s)
[85.340782] [017/130] (920s left) kms_properties (connector-properties-legacy)
[85.456801] Starting subtest: connector-properties-legacy
[85.457478] Starting dynamic subtest: pipe-A-HDMI-A-1
[86.268191] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.810s)
[86.278325] Starting dynamic subtest: pipe-None-HDMI-A-2
[86.279685] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.003s)
[86.286309] Starting dynamic subtest: pipe-None-DP-1
[86.287703] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[86.292545] Starting dynamic subtest: pipe-None-HDMI-A-3
[86.293866] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.002s)
[86.294532] Subtest connector-properties-legacy: SUCCESS (0.820s)
[86.443433] [018/130] (919s left) prime_mmap (test_map_unmap)
[86.485113] Starting subtest: test_map_unmap
[86.485802] Starting dynamic subtest: test_map_unmap-smem
[86.529646] Dynamic subtest test_map_unmap-smem: SUCCESS (0.045s)
[86.530340] Subtest test_map_unmap: SUCCESS (0.045s)
[86.652387] [019/130] (919s left) gem_pread (snoop)
[86.692962] Subtest snoop: SKIP (0.000s)
[86.745056] [020/130] (919s left) gem_softpin (evict-single-offset)
[86.793033] Starting subtest: evict-single-offset
[110.627197] Subtest evict-single-offset: SUCCESS (23.836s)
[110.712919] [021/130] (895s left) kms_flip (dpms-off-confusion)
[110.860470] Starting subtest: dpms-off-confusion
[110.861161] Starting dynamic subtest: A-HDMI-A1
[126.090865] Dynamic subtest A-HDMI-A1: SUCCESS (15.229s)
[126.099226] Starting dynamic subtest: B-HDMI-A1
[141.240730] Dynamic subtest B-HDMI-A1: SUCCESS (15.149s)
[141.242177] Subtest dpms-off-confusion: SUCCESS (30.381s)
[141.380128] [022/130] (864s left) gem_pxp (fail-invalid-protected-context)
[262.390384] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[263.761909] Closing watchdogs
[263.765777] Initializing watchdogs
[263.765822]   /dev/watchdog0
[263.772077] [023/130] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[263.882358] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[263.883669] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[263.999940] [024/130] (741s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[264.126211] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[264.127556] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[264.251325] [025/130] (741s left) prime_vgem (fence-flip-hang)
[264.378381] Subtest fence-flip-hang: SKIP (0.000s)
[264.487758] [026/130] (741s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[264.606944] Starting subtest: x-tiled-16bpp-rotate-180
[266.160605] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.554s)
[266.358664] [027/130] (739s left) syncobj_timeline (single-wait-signaled)
[266.402149] Starting subtest: single-wait-signaled
[266.402833] Subtest single-wait-signaled: SUCCESS (0.000s)
[266.477948] [028/130] (739s left) kms_content_protection (dp-mst-lic-type-1)
[266.597311] Starting subtest: dp-mst-lic-type-1
[266.598678] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[266.720786] [029/130] (739s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[266.835990] Starting subtest: cursor-vs-flip-atomic
[295.729995] Subtest cursor-vs-flip-atomic: SUCCESS (28.893s)
[295.898160] [030/130] (710s left) kms_chamelium_edid (hdmi-mode-timings)
[296.072140] Subtest hdmi-mode-timings: SKIP (0.000s)
[296.131858] [031/130] (709s left) kms_plane_scaling (invalid-parameters)
[296.251951] Starting subtest: invalid-parameters
[296.252698] Starting dynamic subtest: less-than-1-height-src
[296.259479] Dynamic subtest less-than-1-height-src: SUCCESS (0.007s)
[296.265660] Starting dynamic subtest: less-than-1-width-src
[296.267790] Dynamic subtest less-than-1-width-src: SUCCESS (0.007s)
[296.268499] Subtest invalid-parameters: SUCCESS (0.015s)
[296.383657] [032/130] (709s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[296.502086] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[296.529278] [033/130] (709s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[296.638679] Starting subtest: psr-rgb101010-draw-mmap-wc
[296.639976] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[296.784221] [034/130] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[296.897354] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[296.898655] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[297.002622] [035/130] (709s left) gen9_exec_parse (valid-registers)
[297.045436] Subtest valid-registers: SKIP (0.000s)
[297.080372] [036/130] (709s left) i915_query (query-regions-garbage-items)
[297.119447] Starting subtest: query-regions-garbage-items
[297.120153] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[297.193919] [037/130] (708s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[297.303954] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[297.304664] Starting dynamic subtest: pipe-A-valid-mode
[297.355803] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s)
[297.357116] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.051s)
[297.530121] [038/130] (708s left) kms_cursor_crc (cursor-sliding-32x10)
[297.643443] Starting subtest: cursor-sliding-32x10
[297.673925] Subtest cursor-sliding-32x10: SKIP (0.029s)
[297.798449] [039/130] (708s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[297.910896] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[297.911562] Starting dynamic subtest: pipe-A-valid-mode
[297.966353] Dynamic subtest pipe-A-valid-mode: SKIP (0.054s)
[297.967997] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.055s)
[298.081694] [040/130] (708s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[298.195340] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[298.196656] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.302856] [041/130] (707s left) gem_close_race (multigpu-basic-process)
[298.353456] Starting subtest: multigpu-basic-process
[298.354781] Subtest multigpu-basic-process: SKIP (0.000s)
[298.540057] [042/130] (707s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[298.654710] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[299.794032] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.139s)
[299.973623] [043/130] (706s left) gem_eio (in-flight-contexts-immediate)
[300.018993] Starting subtest: in-flight-contexts-immediate
[311.826321] Subtest in-flight-contexts-immediate: SUCCESS (11.807s)
[311.989181] [044/130] (694s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[312.098057] Starting subtest: cursorA-vs-flipB-varying-size
[312.099362] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[312.180844] [045/130] (694s left) kms_chamelium_audio (dp-audio-edid)
[312.349125] Subtest dp-audio-edid: SKIP (0.000s)
[312.411477] [046/130] (694s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[312.530748] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[312.930172] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.400s)
[313.117275] [047/130] (693s left) gem_exec_balancer (bonded-semaphore)
[313.161685] Starting subtest: bonded-semaphore
[314.161308] Subtest bonded-semaphore: SUCCESS (0.999s)
[315.402969] [048/130] (691s left) kms_cursor_legacy (torture-bo)
[315.509968] Starting subtest: torture-bo
[315.510650] Starting dynamic subtest: pipe-A
[321.054276] Dynamic subtest pipe-A: SUCCESS (5.543s)
[321.060326] Starting dynamic subtest: pipe-B
[326.631380] Dynamic subtest pipe-B: SUCCESS (5.577s)
[326.637118] Starting dynamic subtest: all-pipes
[333.053019] Dynamic subtest all-pipes: SUCCESS (6.421s)
[333.053702] Subtest torture-bo: SUCCESS (17.542s)
[333.129781] [049/130] (673s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[333.249758] Starting subtest: y-tiled-8bpp-rotate-0
[334.656218] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.406s)
[334.815906] [050/130] (671s left) kms_universal_plane (universal-plane-functional)
[334.928877] Starting subtest: universal-plane-functional
[334.930394] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.135141] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.204s)
[337.143734] Starting dynamic subtest: pipe-B-HDMI-A-1
[339.201337] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.065s)
[339.202179] Subtest universal-plane-functional: SUCCESS (4.272s)
[339.321316] [051/130] (667s left) gem_media_fill (media-fill)
[339.367810] Starting subtest: media-fill
[339.368501] Starting dynamic subtest: smem
[339.371138] Dynamic subtest smem: SUCCESS (0.003s)
[339.371835] Subtest media-fill: SUCCESS (0.004s)
[339.619241] [052/130] (666s left) syncobj_timeline (device-signal-unordered)
[339.655153] Starting subtest: device-signal-unordered
[339.655860] Subtest device-signal-unordered: SUCCESS (0.000s)
[339.736412] [053/130] (666s left) kms_async_flips (async-flip-with-page-flip-events)
[339.847107] Starting subtest: async-flip-with-page-flip-events
[340.012805] Starting dynamic subtest: pipe-A-HDMI-A-1-y-rc-ccs
[340.158794] Dynamic subtest pipe-A-HDMI-A-1-y-rc-ccs: SKIP (0.145s)
[340.164271] Starting dynamic subtest: pipe-A-HDMI-A-1-y-rc-ccs-cc
[340.311125] Dynamic subtest pipe-A-HDMI-A-1-y-rc-ccs-cc: SKIP (0.151s)
[340.316645] Starting dynamic subtest: pipe-A-HDMI-A-1-y
[342.437691] Dynamic subtest pipe-A-HDMI-A-1-y: SUCCESS (2.126s)
[342.448186] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[344.504337] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.065s)
[344.513237] Starting dynamic subtest: pipe-A-HDMI-A-1-linear
[346.573505] Dynamic subtest pipe-A-HDMI-A-1-linear: SUCCESS (2.067s)
[346.724316] Starting dynamic subtest: pipe-B-HDMI-A-1-y-rc-ccs
[346.857998] Dynamic subtest pipe-B-HDMI-A-1-y-rc-ccs: SKIP (0.137s)
[346.863425] Starting dynamic subtest: pipe-B-HDMI-A-1-y-rc-ccs-cc
[346.990718] Dynamic subtest pipe-B-HDMI-A-1-y-rc-ccs-cc: SKIP (0.133s)
[346.996271] Starting dynamic subtest: pipe-B-HDMI-A-1-y
[349.078590] Dynamic subtest pipe-B-HDMI-A-1-y: SUCCESS (2.087s)
[349.088881] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[351.127895] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.047s)
[351.135760] Starting dynamic subtest: pipe-B-HDMI-A-1-linear
[353.157321] Dynamic subtest pipe-B-HDMI-A-1-linear: SUCCESS (2.029s)
[353.158308] Subtest async-flip-with-page-flip-events: SUCCESS (13.310s)
[353.465059] [054/130] (653s left) kms_content_protection (atomic)
[353.582320] Starting subtest: atomic
[353.757845] Subtest atomic: SKIP (0.173s)
[353.959779] [055/130] (652s left) kms_setmode (basic-clone-single-crtc)
[354.006383] Starting subtest: basic-clone-single-crtc
[354.008367] Subtest basic-clone-single-crtc: SKIP (0.000s)
[354.099102] [056/130] (652s left) i915_pm_rpm (debugfs-forcewake-user)
[355.534601] Starting subtest: debugfs-forcewake-user
[365.962133] Subtest debugfs-forcewake-user: SUCCESS (10.427s)
[366.141548] [057/130] (640s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[366.252934] Starting subtest: psr-1p-primscrn-spr-indfb-move
[366.254250] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[366.390942] [058/130] (640s left) gem_exec_create (basic)
[366.437963] Starting subtest: basic
[366.438669] Starting dynamic subtest: smem
[368.531849] Dynamic subtest smem: SUCCESS (2.093s)
[368.532699] Subtest basic: SUCCESS (2.094s)
[368.707919] [059/130] (638s left) kms_invalid_mode (zero-clock)
[368.827540] Starting subtest: zero-clock
[368.828220] Starting dynamic subtest: pipe-A-HDMI-A-1
[368.867985] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.039s)
[368.873939] Starting dynamic subtest: pipe-B-HDMI-A-1
[368.874665] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[368.875367] Subtest zero-clock: SUCCESS (0.042s)
[369.057638] [060/130] (637s left) kms_pipe_crc_basic (nonblocking-crc)
[369.181361] Starting subtest: nonblocking-crc
[369.183204] Starting dynamic subtest: pipe-A-HDMI-A-1
[369.835900] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.652s)
[369.842782] Starting dynamic subtest: pipe-B-HDMI-A-1
[370.365860] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.529s)
[370.366660] Subtest nonblocking-crc: SUCCESS (1.184s)
[370.472826] [061/130] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[370.587958] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[370.589381] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[370.703902] [062/130] (636s left) kms_psr (psr-primary-mmap-gtt)
[370.813473] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[370.836635] [063/130] (636s left) gem_partial_pwrite_pread (reads-display)
[370.876684] Subtest reads-display: SKIP (0.000s)
[370.958745] [064/130] (635s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[370.998901] Starting subtest: invalid-multi-wait-unsubmitted
[370.999617] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[371.087238] [065/130] (635s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[371.208317] Starting subtest: 2x-plain-flip-ts-check-interruptible
[371.210533] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.001s)
[371.336995] [066/130] (635s left) kms_chamelium_hpd (dp-hpd-storm)
[371.506144] Subtest dp-hpd-storm: SKIP (0.000s)
[371.567870] [067/130] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[371.683364] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[371.684674] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[371.816265] [068/130] (635s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[371.930658] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[371.974126] [069/130] (635s left) kms_plane_scaling (planes-downscale-factor-0-75)
[372.083084] Starting subtest: planes-downscale-factor-0-75
[372.083819] Starting dynamic subtest: pipe-A
[372.181267] Dynamic subtest pipe-A: SUCCESS (0.098s)
[372.196576] Starting dynamic subtest: pipe-B
[372.327841] Dynamic subtest pipe-B: SUCCESS (0.145s)
[372.329204] Subtest planes-downscale-factor-0-75: SUCCESS (0.245s)
[372.527622] [070/130] (634s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[372.643445] Starting subtest: cursor-rapid-movement-256x256
[372.645991] Starting dynamic subtest: pipe-A-HDMI-A-1
[373.040693] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.394s)
[373.066747] Starting dynamic subtest: pipe-B-HDMI-A-1
[373.367090] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.304s)
[373.367915] Subtest cursor-rapid-movement-256x256: SUCCESS (0.724s)
[373.552451] [071/130] (633s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[373.661065] Starting subtest: multiplane-rotation-cropping-bottom
[395.545786] Subtest multiplane-rotation-cropping-bottom: SUCCESS (21.884s)
[395.682050] [072/130] (611s left) gen9_exec_parse (allowed-all)
[395.722006] Subtest allowed-all: SKIP (0.000s)
[395.742433] [073/130] (611s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[395.866831] Starting subtest: 4-tiled-16bpp-rotate-180
[395.868158] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[396.002160] [074/130] (611s left) gem_mmap_offset (bad-flags)
[396.038538] Starting subtest: bad-flags
[396.039286] Subtest bad-flags: SUCCESS (0.000s)
[396.162167] [075/130] (610s left) prime_self_import (export-vs-gem_close-race)
[396.203476] Starting subtest: export-vs-gem_close-race
[401.258828] Subtest export-vs-gem_close-race: SUCCESS (5.054s)
[401.359117] [076/130] (605s left) gem_eio (in-flight-internal-1us)
[401.443441] Starting subtest: in-flight-internal-1us
[401.703619] Subtest in-flight-internal-1us: SUCCESS (0.260s)
[401.858198] [077/130] (605s left) gem_ctx_persistence (engines-cleanup)
[401.895115] Starting subtest: engines-cleanup
[401.895873] Starting dynamic subtest: rcs0
[401.937414] Dynamic subtest rcs0: SUCCESS (0.041s)
[401.957957] Starting dynamic subtest: bcs0
[401.981337] Dynamic subtest bcs0: SUCCESS (0.041s)
[402.001389] Starting dynamic subtest: vcs0
[402.032340] Dynamic subtest vcs0: SUCCESS (0.048s)
[402.052986] Starting dynamic subtest: vecs0
[402.072326] Dynamic subtest vecs0: SUCCESS (0.037s)
[402.076572] Subtest engines-cleanup: SUCCESS (0.178s)
[402.164303] [078/130] (605s left) gem_exec_schedule (implicit-read-write)
[402.211347] Starting subtest: implicit-read-write
[402.212122] Starting dynamic subtest: rcs0
[402.264770] Dynamic subtest rcs0: SUCCESS (0.053s)
[402.277528] Starting dynamic subtest: bcs0
[402.321692] Dynamic subtest bcs0: SUCCESS (0.054s)
[402.334653] Starting dynamic subtest: vcs0
[402.379119] Dynamic subtest vcs0: SUCCESS (0.055s)
[402.388263] Starting dynamic subtest: vecs0
[402.428228] Dynamic subtest vecs0: SUCCESS (0.047s)
[402.431637] Subtest implicit-read-write: SUCCESS (0.218s)
[402.754487] [079/130] (604s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[402.865706] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[402.867037] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[402.995298] [080/130] (604s left) kms_flip (bo-too-big)
[403.103579] Starting subtest: bo-too-big
[403.105430] Starting dynamic subtest: A-HDMI-A1
[403.459738] Dynamic subtest A-HDMI-A1: SUCCESS (0.354s)
[403.473521] Starting dynamic subtest: B-HDMI-A1
[403.753397] Dynamic subtest B-HDMI-A1: SUCCESS (0.290s)
[403.756303] Subtest bo-too-big: SUCCESS (0.652s)
[403.973277] [081/130] (603s left) syncobj_wait (single-wait-all-submitted)
[404.011678] Starting subtest: single-wait-all-submitted
[404.115548] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[404.200344] [082/130] (603s left) gem_exec_fence (syncobj-timeline-chain-engines)
[404.665203] Starting subtest: syncobj-timeline-chain-engines
[404.697626] Subtest syncobj-timeline-chain-engines: SUCCESS (0.033s)
[404.896150] [083/130] (602s left) gem_create (create-ext-placement-sanity-check)
[405.054741] Starting subtest: create-ext-placement-sanity-check
[405.060974] Subtest create-ext-placement-sanity-check: SUCCESS (0.007s)
[405.189173] [084/130] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[405.300944] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[405.302487] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[405.427639] [085/130] (602s left) kms_plane_multiple (tiling-x)
[405.547085] Starting subtest: tiling-x
[405.548845] Starting dynamic subtest: pipe-A-HDMI-A-1
[406.201948] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.653s)
[406.207858] Starting dynamic subtest: pipe-B-HDMI-A-1
[406.755901] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.553s)
[406.756585] Subtest tiling-x: SUCCESS (1.208s)
[406.928123] [086/130] (600s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[407.042686] Starting subtest: fbcpsr-indfb-scaledprimary
[407.043990] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[407.194715] [087/130] (600s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[407.231373] Starting subtest: etime-single-wait-for-submit-submitted
[407.339680] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[407.442327] [088/130] (600s left) gem_softpin (evict-snoop-interruptible)
[407.483490] Starting subtest: evict-snoop-interruptible
[407.484866] Subtest evict-snoop-interruptible: SKIP (0.000s)
[407.572406] [089/130] (599s left) gem_exec_schedule (u-submit-late-slice)
[407.621730] Starting subtest: u-submit-late-slice
[407.622409] Starting dynamic subtest: rcs0
[407.639889] Dynamic subtest rcs0: SUCCESS (0.018s)
[407.645884] Starting dynamic subtest: bcs0
[407.656954] Dynamic subtest bcs0: SUCCESS (0.016s)
[407.666317] Starting dynamic subtest: vcs0
[407.675971] Dynamic subtest vcs0: SUCCESS (0.018s)
[407.681877] Starting dynamic subtest: vecs0
[407.693215] Dynamic subtest vecs0: SUCCESS (0.016s)
[407.693911] Subtest u-submit-late-slice: SUCCESS (0.072s)
[408.022881] [090/130] (599s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[408.135098] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[408.136788] Starting dynamic subtest: pipe-A-HDMI-A-1
[408.143235] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[408.149050] Starting dynamic subtest: pipe-B-HDMI-A-1
[408.155493] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[408.156791] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.002s)
[408.357759] [091/130] (599s left) perf_pmu (most-busy-idle-check-all)
[408.397423] Starting subtest: most-busy-idle-check-all
[408.398119] Starting dynamic subtest: rcs0
[409.051246] Dynamic subtest rcs0: FAIL (0.637s)
[409.069826] Starting dynamic subtest: bcs0
[409.666333] Dynamic subtest bcs0: SUCCESS (0.629s)
[409.677361] Starting dynamic subtest: vcs0
[410.297272] Dynamic subtest vcs0: SUCCESS (0.628s)
[410.308504] Starting dynamic subtest: vecs0
[410.927346] Dynamic subtest vecs0: SUCCESS (0.627s)
[410.928783] Subtest most-busy-idle-check-all: FAIL (2.531s)
[411.011164] [092/130] (596s left) gem_exec_balancer (parallel-out-fence)
[412.221973] Subtest parallel-out-fence: SKIP (0.000s)
[412.293257] [093/130] (595s left) gem_exec_fence (basic-await)
[412.462137] Starting subtest: basic-await
[412.464935] Starting dynamic subtest: rcs0
[412.543286] Dynamic subtest rcs0: SUCCESS (0.079s)
[412.562494] Starting dynamic subtest: bcs0
[412.629601] Dynamic subtest bcs0: SUCCESS (0.083s)
[412.648063] Starting dynamic subtest: vcs0
[412.716696] Dynamic subtest vcs0: SUCCESS (0.083s)
[412.736050] Starting dynamic subtest: vecs0
[412.803901] Dynamic subtest vecs0: SUCCESS (0.082s)
[412.805300] Subtest basic-await: SUCCESS (0.342s)
[413.265980] [094/130] (594s left) syncobj_basic (bad-create-flags)
[413.301807] Starting subtest: bad-create-flags
[413.302469] Subtest bad-create-flags: SUCCESS (0.000s)
[413.382666] [095/130] (594s left) kms_pm_rpm (pm-caching)
[414.820187] Starting subtest: pm-caching
[416.183299] Subtest pm-caching: SUCCESS (1.362s)
[416.357309] [096/130] (591s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[416.469878] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[416.471226] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[416.614784] [097/130] (591s left) gem_flink_basic (double-flink)
[416.651678] Starting subtest: double-flink
[416.652346] Subtest double-flink: SUCCESS (0.000s)
[416.774256] [098/130] (591s left) prime_vgem (busy)
[416.838282] Starting subtest: busy
[416.841303] Starting dynamic subtest: rcs0
[416.891241] Dynamic subtest rcs0: SUCCESS (0.052s)
[416.910449] Starting dynamic subtest: bcs0
[416.926303] Dynamic subtest bcs0: SUCCESS (0.032s)
[416.942470] Starting dynamic subtest: vcs0
[416.953710] Dynamic subtest vcs0: SUCCESS (0.025s)
[416.965631] Starting dynamic subtest: vecs0
[416.989492] Dynamic subtest vecs0: SUCCESS (0.034s)
[416.993859] Subtest busy: SUCCESS (0.153s)
[417.165603] [099/130] (590s left) prime_self_import (basic-with_one_bo)
[417.198965] Starting subtest: basic-with_one_bo
[417.200314] Subtest basic-with_one_bo: SUCCESS (0.002s)
[417.281529] [100/130] (590s left) kms_vrr (flip-basic)
[417.393121] Starting subtest: flip-basic
[417.395083] Subtest flip-basic: SKIP (0.000s)
[417.476181] [101/130] (590s left) kms_draw_crc (draw-method-mmap-cpu)
[417.588745] Starting subtest: draw-method-mmap-cpu
[417.589417] Starting dynamic subtest: xrgb8888-untiled
[417.904086] Dynamic subtest xrgb8888-untiled: SUCCESS (0.315s)
[417.915049] Starting dynamic subtest: rgb565-untiled
[418.226552] Dynamic subtest rgb565-untiled: SUCCESS (0.320s)
[418.248268] Starting dynamic subtest: xrgb2101010-untiled
[418.530192] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.301s)
[418.550804] Starting dynamic subtest: xrgb8888-xtiled
[418.700923] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.168s)
[418.722397] Starting dynamic subtest: rgb565-xtiled
[418.871731] Dynamic subtest rgb565-xtiled: SUCCESS (0.168s)
[418.884997] Starting dynamic subtest: xrgb2101010-xtiled
[419.023520] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s)
[419.039469] Starting dynamic subtest: xrgb8888-ytiled
[419.194271] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.168s)
[419.215779] Starting dynamic subtest: rgb565-ytiled
[419.365070] Dynamic subtest rgb565-ytiled: SUCCESS (0.168s)
[419.386675] Starting dynamic subtest: xrgb2101010-ytiled
[419.516888] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.149s)
[419.518260] Subtest draw-method-mmap-cpu: SUCCESS (1.930s)
[419.630603] [102/130] (588s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[419.745144] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[419.746564] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[419.878295] [103/130] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[419.987726] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[419.989045] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[420.123609] [104/130] (587s left) syncobj_wait (wait-for-submit-snapshot)
[420.159019] Starting subtest: wait-for-submit-snapshot
[420.241470] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[420.329426] [105/130] (587s left) gem_exec_whisper (basic-forked)
[420.371953] Starting subtest: basic-forked
[422.106154] Subtest basic-forked: SUCCESS (1.734s)
[422.320227] [106/130] (585s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[422.440721] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[422.442024] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[422.571045] [107/130] (585s left) gem_ctx_persistence (legacy-engines-hang)
[422.611501] Starting subtest: legacy-engines-hang
[422.612282] Starting dynamic subtest: render
[422.661503] Dynamic subtest render: SUCCESS (0.049s)
[422.682831] Starting dynamic subtest: bsd
[422.756363] Dynamic subtest bsd: SUCCESS (0.092s)
[422.779505] Starting dynamic subtest: blt
[422.838377] Dynamic subtest blt: SUCCESS (0.079s)
[422.861056] Starting dynamic subtest: vebox
[422.913381] Dynamic subtest vebox: SUCCESS (0.070s)
[422.917377] Subtest legacy-engines-hang: SUCCESS (0.303s)
[423.000441] [108/130] (585s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[423.047447] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[423.048131] Starting dynamic subtest: smem
[423.184711] Dynamic subtest smem: SUCCESS (0.137s)
[423.185400] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.137s)
[423.380522] [109/130] (584s left) api_intel_bb (add-remove-objects)
[423.422018] Starting subtest: add-remove-objects
[423.424609] Subtest add-remove-objects: SUCCESS (0.004s)
[423.546916] [110/130] (584s left) kms_psr (pr-primary-page-flip)
[423.654474] Subtest pr-primary-page-flip: SKIP (0.000s)
[423.689161] [111/130] (584s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[423.797294] Starting subtest: cursorB-vs-flipA-varying-size
[423.799637] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[423.878347] [112/130] (584s left) kms_lease (lease-get)
[423.992155] Starting subtest: lease-get
[423.993931] Starting dynamic subtest: pipe-A-HDMI-A-1
[423.994610] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[424.001037] Starting dynamic subtest: pipe-B-HDMI-A-1
[424.001753] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[424.002428] Subtest lease-get: SUCCESS (0.004s)
[424.087134] [113/130] (584s left) perf (invalid-open-flags)
[424.201329] Starting subtest: invalid-open-flags
[424.202071] Subtest invalid-open-flags: SUCCESS (0.000s)
[424.241104] [114/130] (583s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[424.354186] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[424.356047] Starting dynamic subtest: pipe-A-HDMI-A-1
[424.374269] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[424.380600] Starting dynamic subtest: pipe-B-HDMI-A-1
[424.397239] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[424.398532] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.006s)
[424.589073] [115/130] (583s left) gem_exec_schedule (preempt-engines)
[424.633338] Starting subtest: preempt-engines
[424.634028] Starting dynamic subtest: rcs0
[424.695952] Dynamic subtest rcs0: SUCCESS (0.062s)
[424.702769] Starting dynamic subtest: bcs0
[424.757063] Dynamic subtest bcs0: SUCCESS (0.060s)
[424.765376] Starting dynamic subtest: vcs0
[424.823139] Dynamic subtest vcs0: SUCCESS (0.065s)
[424.831863] Starting dynamic subtest: vecs0
[424.887268] Dynamic subtest vecs0: SUCCESS (0.063s)
[424.887987] Subtest preempt-engines: SUCCESS (0.254s)
[425.217017] [116/130] (583s left) api_intel_bb (reset-flags)
[425.252649] Starting subtest: reset-flags
[425.256829] Subtest reset-flags: SUCCESS (0.005s)
[425.388281] [117/130] (582s left) gem_linear_blits (interruptible)
[425.594455] Starting subtest: interruptible
[428.538981] Subtest interruptible: SUCCESS (2.944s)
[428.666112] [118/130] (579s left) gem_eio (in-flight-internal-10ms)
[428.755759] Starting subtest: in-flight-internal-10ms
[429.020077] Subtest in-flight-internal-10ms: SUCCESS (0.263s)
[429.187038] [119/130] (579s left) drm_fdinfo (context-close-stress)
[429.227742] Starting subtest: context-close-stress
[439.973920] Subtest context-close-stress: SUCCESS (10.746s)
[440.043687] [120/130] (568s left) kms_psr (pr-cursor-mmap-cpu)
[440.155606] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[440.175986] [121/130] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[440.289619] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[440.290920] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[440.406041] [122/130] (568s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[440.515142] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[440.516848] Starting dynamic subtest: pipe-A-HDMI-A-1
[440.530452] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[440.536906] Starting dynamic subtest: pipe-B-HDMI-A-1
[440.543874] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[440.545268] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.003s)
[440.744711] [123/130] (567s left) gem_pxp (verify-pxp-stale-ctx-execution)
[561.563824] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[564.183256] Closing watchdogs
[564.184429] Initializing watchdogs
[564.184467]   /dev/watchdog0
[564.192246] [124/130] (444s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[564.298224] Starting subtest: flip-vs-cursor-crc-legacy
[564.849341] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.550s)
[565.027517] [125/130] (443s left) kms_addfb_basic (bo-too-small)
[565.139174] Starting subtest: bo-too-small
[565.139911] Subtest bo-too-small: SUCCESS (0.000s)
[565.279606] [126/130] (443s left) gem_exec_reloc (basic-gtt-cpu-active)
[565.324480] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[565.414099] [127/130] (443s left) drm_fdinfo (most-busy-idle-check-all)
[565.448286] Starting subtest: most-busy-idle-check-all
[565.448980] Starting dynamic subtest: rcs0
[566.101357] Dynamic subtest rcs0: SUCCESS (0.652s)
[566.113268] Starting dynamic subtest: bcs0
[566.737483] Dynamic subtest bcs0: SUCCESS (0.634s)
[566.749315] Starting dynamic subtest: vcs0
[567.367452] Dynamic subtest vcs0: SUCCESS (0.628s)
[567.378981] Starting dynamic subtest: vecs0
[568.007328] Dynamic subtest vecs0: SUCCESS (0.637s)
[568.008501] Subtest most-busy-idle-check-all: SUCCESS (2.560s)
[568.093683] [128/130] (440s left) i915_query (query-topology-known-pci-ids)
[568.129777] Starting subtest: query-topology-known-pci-ids
[568.131250] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[568.206379] [129/130] (440s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[568.335576] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[568.359389] [130/130] (440s left) kms_psr (fbc-pr-primary-mmap-gtt)
[568.472445] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[568.491878] Closing watchdogs
Done.