[40.750472] Initializing watchdogs [40.750513] /dev/watchdog0 [40.756897] [001/130] (960s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [40.811320] Starting subtest: wait-all-for-submit-delayed-submit [40.912629] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.101s) [40.985432] [002/130] (960s left) sysfs_defaults (readonly) [41.045492] Starting subtest: readonly [41.046383] Starting dynamic subtest: vecs0 [41.047352] Dynamic subtest vecs0: SUCCESS (0.000s) [41.051939] Starting dynamic subtest: ccs0 [41.052784] Dynamic subtest ccs0: SUCCESS (0.000s) [41.057859] Starting dynamic subtest: vcs0 [41.058678] Dynamic subtest vcs0: SUCCESS (0.000s) [41.063191] Starting dynamic subtest: bcs0 [41.064141] Dynamic subtest bcs0: SUCCESS (0.000s) [41.070073] Starting dynamic subtest: vecs1 [41.071058] Dynamic subtest vecs1: SUCCESS (0.000s) [41.075559] Starting dynamic subtest: rcs0 [41.076386] Dynamic subtest rcs0: SUCCESS (0.000s) [41.081191] Starting dynamic subtest: vcs1 [41.082128] Dynamic subtest vcs1: SUCCESS (0.000s) [41.083182] Subtest readonly: SUCCESS (0.002s) [41.111529] [003/130] (960s left) gen9_exec_parse (unaligned-jump) [41.171391] Subtest unaligned-jump: SKIP (0.000s) [41.206284] [004/130] (960s left) gem_mmap_wc (invalid-flags) [41.260182] Subtest invalid-flags: SKIP (0.000s) [41.289560] [005/130] (960s left) kms_properties (crtc-properties-atomic) [43.132247] Starting subtest: crtc-properties-atomic [43.133239] Starting dynamic subtest: pipe-A-HDMI-A-3 [43.425209] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.287s) [43.444229] Starting dynamic subtest: pipe-B-HDMI-A-3 [43.719958] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.288s) [43.726067] Starting dynamic subtest: pipe-C-HDMI-A-3 [43.975970] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.252s) [43.982169] Starting dynamic subtest: pipe-D-HDMI-A-3 [44.217475] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.237s) [44.218577] Subtest crtc-properties-atomic: SUCCESS (1.069s) [44.357858] [006/130] (956s left) gem_ctx_param (invalid-ctx-get) [44.428193] Starting subtest: invalid-ctx-get [44.428994] Subtest invalid-ctx-get: SUCCESS (0.000s) [44.494699] [007/130] (956s left) gem_pxp (fail-invalid-protected-context) [47.103582] Subtest fail-invalid-protected-context: SKIP (0.000s) [47.159589] [008/130] (954s left) syncobj_eventfd (timeline-wait-before-signal) [47.212204] Starting subtest: timeline-wait-before-signal [47.243141] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [47.335125] [009/130] (954s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [49.366822] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [49.368449] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [49.443986] [010/130] (952s left) gem_exec_reloc (basic-softpin) [49.569736] Subtest basic-softpin: SKIP (0.000s) [49.631317] [011/130] (951s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [51.651986] Starting subtest: primary-y-tiled-reflect-x-0 [51.743780] Subtest primary-y-tiled-reflect-x-0: SKIP (0.090s) [51.830404] [012/130] (949s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [53.882134] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [53.883027] Starting dynamic subtest: pipe-A-HDMI-A-3 [53.891032] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.002s) [53.896055] Starting dynamic subtest: pipe-B-HDMI-A-3 [53.903383] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.002s) [53.908450] Starting dynamic subtest: pipe-C-HDMI-A-3 [53.916099] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.002s) [53.920992] Starting dynamic subtest: pipe-D-HDMI-A-3 [53.928479] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.002s) [53.929325] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.011s) [54.062151] [013/130] (947s left) gem_madvise (dontneed-before-mmap) [54.129760] Starting subtest: dontneed-before-mmap [54.142372] Subtest dontneed-before-mmap: SUCCESS (0.013s) [54.267315] [014/130] (947s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [56.307759] Starting subtest: psr-rgb565-draw-mmap-gtt [56.309307] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [56.370779] [015/130] (945s left) kms_joiner (basic-big-joiner) [58.401025] Starting subtest: basic-big-joiner [58.402856] Subtest basic-big-joiner: SKIP (0.000s) [58.458029] [016/130] (943s left) gem_exec_schedule (thriceslice) [58.537177] Starting subtest: thriceslice [58.538264] Starting dynamic subtest: rcs0 [58.591546] Dynamic subtest rcs0: SUCCESS (0.054s) [58.604342] Starting dynamic subtest: bcs0 [58.626173] Dynamic subtest bcs0: SUCCESS (0.034s) [58.644432] Starting dynamic subtest: vcs0 [58.693692] Dynamic subtest vcs0: SUCCESS (0.067s) [58.715831] Starting dynamic subtest: vcs1 [58.760544] Dynamic subtest vcs1: SUCCESS (0.067s) [58.779769] Starting dynamic subtest: vecs0 [58.803739] Dynamic subtest vecs0: SUCCESS (0.043s) [58.821266] Starting dynamic subtest: vecs1 [58.870580] Dynamic subtest vecs1: SUCCESS (0.066s) [58.890525] Starting dynamic subtest: ccs0 [58.914190] Dynamic subtest ccs0: SUCCESS (0.043s) [58.916067] Subtest thriceslice: SUCCESS (0.376s) [59.201861] [017/130] (942s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [61.206960] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [61.224628] [018/130] (940s left) prime_busy (hang) [61.274287] Starting subtest: hang [61.276420] Starting dynamic subtest: rcs0 [87.868266] Dynamic subtest rcs0: SUCCESS (26.581s) [87.873519] Starting dynamic subtest: bcs0 [95.017921] Dynamic subtest bcs0: SUCCESS (7.149s) [95.023118] Starting dynamic subtest: vcs0 [101.994791] Dynamic subtest vcs0: SUCCESS (6.976s) [101.999860] Starting dynamic subtest: vcs1 [109.037567] Dynamic subtest vcs1: SUCCESS (7.042s) [109.042785] Starting dynamic subtest: vecs0 [116.016027] Dynamic subtest vecs0: SUCCESS (6.977s) [116.020992] Starting dynamic subtest: vecs1 [123.050588] Dynamic subtest vecs1: SUCCESS (7.034s) [123.055906] Starting dynamic subtest: ccs0 [136.886863] Dynamic subtest ccs0: SUCCESS (13.836s) [136.887732] Subtest hang: SUCCESS (75.597s) [136.987982] [019/130] (864s left) gem_softpin (noreloc-interruptible) [137.043186] Starting subtest: noreloc-interruptible [142.421406] Subtest noreloc-interruptible: SUCCESS (5.378s) [142.542165] [020/130] (859s left) gem_pipe_control_store_loop (reused-buffer) [142.606343] Starting subtest: reused-buffer [144.780300] Subtest reused-buffer: SUCCESS (2.174s) [144.914488] [021/130] (856s left) perf (create-destroy-userspace-config) [145.267469] Starting subtest: create-destroy-userspace-config [145.286820] Subtest create-destroy-userspace-config: SUCCESS (0.019s) [145.312218] [022/130] (856s left) kms_atomic_interruptible (legacy-dpms) [147.348162] Starting subtest: legacy-dpms [147.349122] Starting dynamic subtest: pipe-A-HDMI-A-3 [153.508426] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.159s) [153.509337] Subtest legacy-dpms: SUCCESS (6.160s) [153.608962] [023/130] (848s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [155.640528] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [155.642178] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [155.709778] [024/130] (846s left) gem_ctx_freq (sysfs) [155.879212] Starting subtest: sysfs [155.880133] Starting dynamic subtest: gt0 [161.446785] Dynamic subtest gt0: SUCCESS (5.566s) [161.448635] Subtest sysfs: SUCCESS (5.567s) [161.542645] [025/130] (840s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [163.587582] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [163.589225] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [163.659530] [026/130] (838s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [165.767980] Starting subtest: plane-downscale-factor-0-5-with-rotation [165.768930] Starting dynamic subtest: pipe-A [166.145998] Dynamic subtest pipe-A: SUCCESS (0.377s) [166.165192] Starting dynamic subtest: pipe-B [166.552888] Dynamic subtest pipe-B: SUCCESS (0.407s) [166.567247] Starting dynamic subtest: pipe-C [166.959803] Dynamic subtest pipe-C: SUCCESS (0.407s) [166.975049] Starting dynamic subtest: pipe-D [167.367620] Dynamic subtest pipe-D: SUCCESS (0.408s) [167.368965] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.599s) [167.523045] [027/130] (834s left) gem_ctx_shared (detached-shared-gtt) [167.615483] Starting subtest: detached-shared-gtt [169.766236] Subtest detached-shared-gtt: SUCCESS (2.150s) [172.186655] [028/130] (829s left) kms_cursor_crc (cursor-rapid-movement-64x64) [174.314420] Starting subtest: cursor-rapid-movement-64x64 [174.318700] Starting dynamic subtest: pipe-A-HDMI-A-3 [174.711147] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.393s) [174.735336] Starting dynamic subtest: pipe-D-HDMI-A-3 [175.034305] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.304s) [175.035146] Subtest cursor-rapid-movement-64x64: SUCCESS (0.719s) [175.332791] [029/130] (826s left) kms_addfb_basic (addfb25-x-tiled-legacy) [175.430643] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [177.447555] [030/130] (824s left) kms_psr (fbc-pr-primary-mmap-cpu) [179.546304] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [179.573654] [031/130] (822s left) kms_big_fb (y-tiled-64bpp-rotate-0) [181.620495] Starting subtest: y-tiled-64bpp-rotate-0 [181.622459] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [181.687794] [032/130] (820s left) kms_flip (dpms-off-confusion-interruptible) [183.779846] Starting subtest: dpms-off-confusion-interruptible [183.786849] Starting dynamic subtest: A-HDMI-A3 [191.490700] Dynamic subtest A-HDMI-A3: SUCCESS (7.703s) [191.498062] Starting dynamic subtest: B-HDMI-A3 [199.131887] Dynamic subtest B-HDMI-A3: SUCCESS (7.640s) [199.138103] Starting dynamic subtest: C-HDMI-A3 [206.774984] Dynamic subtest C-HDMI-A3: SUCCESS (7.642s) [206.801197] Starting dynamic subtest: D-HDMI-A3 [214.464075] Dynamic subtest D-HDMI-A3: SUCCESS (7.688s) [214.464993] Subtest dpms-off-confusion-interruptible: SUCCESS (30.683s) [214.618352] [033/130] (787s left) perf_pmu (busy-accuracy-50) [214.718429] Starting subtest: busy-accuracy-50 [214.719297] Starting dynamic subtest: rcs0 [216.265629] Dynamic subtest rcs0: SUCCESS (1.546s) [216.271734] Starting dynamic subtest: bcs0 [217.811698] Dynamic subtest bcs0: SUCCESS (1.546s) [217.817911] Starting dynamic subtest: vcs0 [219.356722] Dynamic subtest vcs0: SUCCESS (1.545s) [219.362887] Starting dynamic subtest: vcs1 [220.899552] Dynamic subtest vcs1: SUCCESS (1.543s) [220.907009] Starting dynamic subtest: vecs0 [222.445139] Dynamic subtest vecs0: SUCCESS (1.545s) [222.451592] Starting dynamic subtest: vecs1 [223.991887] Dynamic subtest vecs1: SUCCESS (1.547s) [223.997784] Starting dynamic subtest: ccs0 [225.538068] Dynamic subtest ccs0: SUCCESS (1.546s) [225.538892] Subtest busy-accuracy-50: SUCCESS (10.818s) [225.637167] [034/130] (776s left) kms_big_fb (yf-tiled-addfb) [227.670118] Starting subtest: yf-tiled-addfb [227.671879] Subtest yf-tiled-addfb: SKIP (0.000s) [227.755821] [035/130] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [229.877837] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [229.879548] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [229.954218] [036/130] (771s left) kms_rotation_crc (primary-rotation-270) [232.063709] Starting subtest: primary-rotation-270 [232.065420] Subtest primary-rotation-270: SKIP (0.001s) [232.117880] [037/130] (769s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [234.199874] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [234.738335] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.538s) [234.897730] [038/130] (767s left) kms_content_protection (dp-mst-lic-type-1) [236.981299] Starting subtest: dp-mst-lic-type-1 [236.982982] Subtest dp-mst-lic-type-1: SKIP (0.000s) [237.109579] [039/130] (764s left) kms_hdr (static-toggle-suspend) [239.194904] Starting subtest: static-toggle-suspend [239.197589] Subtest static-toggle-suspend: SKIP (0.000s) [239.251061] [040/130] (762s left) kms_psr (fbc-psr-suspend) [241.326178] Subtest fbc-psr-suspend: SKIP (0.000s) [241.345764] [041/130] (760s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [243.381606] Starting subtest: psr-1p-pri-indfb-multidraw [243.383325] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s) [243.453326] [042/130] (758s left) api_intel_bb (blit-noreloc-purge-cache) [243.612854] Starting subtest: blit-noreloc-purge-cache [243.639828] Subtest blit-noreloc-purge-cache: SUCCESS (0.027s) [243.745708] [043/130] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [245.812579] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [245.814149] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [245.888986] [044/130] (756s left) gem_exec_fence (invalid-fence-array) [246.500833] Starting subtest: invalid-fence-array [246.502600] Subtest invalid-fence-array: SUCCESS (0.001s) [246.814892] [045/130] (755s left) kms_chamelium_hpd (hdmi-hpd) [248.878481] Subtest hdmi-hpd: SKIP (0.000s) [248.928570] [046/130] (753s left) gen9_exec_parse (allowed-single) [249.042025] Subtest allowed-single: SKIP (0.000s) [249.080083] [047/130] (753s left) gem_sync (basic-store-each) [249.192338] Starting subtest: basic-store-each [251.912273] Subtest basic-store-each: SUCCESS (2.720s) [252.113476] [048/130] (750s left) gem_exec_balancer (bonded-true-hang) [252.452552] Starting subtest: bonded-true-hang [252.454579] Subtest bonded-true-hang: SKIP (0.000s) [252.534501] [049/130] (749s left) perf_pmu (render-node-busy) [252.628271] Starting subtest: render-node-busy [252.629199] Starting dynamic subtest: rcs0 [253.204041] Dynamic subtest rcs0: SUCCESS (0.575s) [253.214167] Starting dynamic subtest: bcs0 [253.762959] Dynamic subtest bcs0: SUCCESS (0.558s) [253.772950] Starting dynamic subtest: vcs0 [254.316813] Dynamic subtest vcs0: SUCCESS (0.553s) [254.326943] Starting dynamic subtest: vcs1 [254.874931] Dynamic subtest vcs1: SUCCESS (0.557s) [254.884829] Starting dynamic subtest: vecs0 [255.427776] Dynamic subtest vecs0: SUCCESS (0.552s) [255.437806] Starting dynamic subtest: vecs1 [255.980936] Dynamic subtest vecs1: SUCCESS (0.552s) [255.991143] Starting dynamic subtest: ccs0 [256.535904] Dynamic subtest ccs0: SUCCESS (0.554s) [256.537811] Subtest render-node-busy: SUCCESS (3.907s) [256.606697] [050/130] (745s left) drm_fdinfo (memory-info-purgeable) [256.687849] Starting subtest: memory-info-purgeable [256.688747] Starting dynamic subtest: lmem0 [259.857401] Dynamic subtest lmem0: SUCCESS (3.169s) [259.867996] Starting dynamic subtest: smem0 [263.648681] Dynamic subtest smem0: SUCCESS (3.791s) [263.649541] Subtest memory-info-purgeable: SUCCESS (6.960s) [263.697654] [051/130] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [265.738282] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [265.739999] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [265.820684] [052/130] (736s left) core_setmaster (master-drop-set-user) [266.819241] Starting subtest: master-drop-set-user [266.839225] Subtest master-drop-set-user: SUCCESS (0.020s) [266.850575] [053/130] (735s left) gem_ctx_sseu (mmap-args) [266.938244] Subtest mmap-args: SKIP (0.000s) [266.977354] [054/130] (735s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [269.015135] Starting subtest: fbcpsr-farfromfence-mmap-gtt [269.016803] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [269.105290] [055/130] (733s left) syncobj_timeline (reset-unsignaled) [269.277165] Starting subtest: reset-unsignaled [269.278045] Subtest reset-unsignaled: SUCCESS (0.000s) [269.365238] [056/130] (732s left) i915_pm_rps (fence-order) [269.497626] Starting subtest: fence-order [273.717680] Subtest fence-order: SUCCESS (4.219s) [273.952894] [057/130] (728s left) kms_draw_crc (fill-fb) [275.982277] Starting subtest: fill-fb [276.470499] Subtest fill-fb: SUCCESS (0.488s) [276.557769] [058/130] (725s left) kms_chamelium_color (ctm-max) [278.589203] Subtest ctm-max: SKIP (0.000s) [278.611892] [059/130] (723s left) gem_exec_parallel (userptr) [278.701435] Starting subtest: userptr [278.702348] Starting dynamic subtest: rcs0 [280.267363] Dynamic subtest rcs0: SUCCESS (1.566s) [280.273702] Starting dynamic subtest: bcs0 [281.639998] Dynamic subtest bcs0: SUCCESS (1.372s) [281.647276] Starting dynamic subtest: vcs0 [283.062057] Dynamic subtest vcs0: SUCCESS (1.422s) [283.069245] Starting dynamic subtest: vcs1 [284.488782] Dynamic subtest vcs1: SUCCESS (1.426s) [284.495506] Starting dynamic subtest: vecs0 [285.879860] Dynamic subtest vecs0: SUCCESS (1.391s) [285.886542] Starting dynamic subtest: vecs1 [287.272781] Dynamic subtest vecs1: SUCCESS (1.393s) [287.279195] Starting dynamic subtest: ccs0 [288.673503] Dynamic subtest ccs0: SUCCESS (1.400s) [288.674556] Subtest userptr: SUCCESS (9.972s) [288.913912] [060/130] (713s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [290.997620] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [290.999279] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [291.069946] [061/130] (711s left) gem_gtt_cpu_tlb [291.278597] [062/130] (711s left) kms_pm_rpm (cursor-dpms) [296.484906] Starting subtest: cursor-dpms [307.361984] Subtest cursor-dpms: SUCCESS (10.877s) [308.513026] [063/130] (693s left) kms_flip (bo-too-big) [310.615966] Starting subtest: bo-too-big [310.621148] Starting dynamic subtest: A-HDMI-A3 [310.820890] Dynamic subtest A-HDMI-A3: SUCCESS (0.199s) [310.835072] Starting dynamic subtest: B-HDMI-A3 [311.020514] Dynamic subtest B-HDMI-A3: SUCCESS (0.199s) [311.027801] Starting dynamic subtest: C-HDMI-A3 [311.172022] Dynamic subtest C-HDMI-A3: SUCCESS (0.151s) [311.179981] Starting dynamic subtest: D-HDMI-A3 [311.318917] Dynamic subtest D-HDMI-A3: SUCCESS (0.146s) [311.319884] Subtest bo-too-big: SUCCESS (0.704s) [311.506852] [064/130] (690s left) gem_lmem_swapping (basic) [317.104143] Starting subtest: basic [317.104939] Starting dynamic subtest: lmem0 [330.657952] Dynamic subtest lmem0: SUCCESS (13.553s) [330.658833] Subtest basic: SUCCESS (13.554s) [332.568561] [065/130] (669s left) syncobj_timeline (etime-multi-wait-submitted) [336.210992] Starting subtest: etime-multi-wait-submitted [336.318771] Subtest etime-multi-wait-submitted: SUCCESS (0.108s) [336.372237] [066/130] (666s left) gem_exec_store (cachelines) [336.476693] Starting subtest: cachelines [336.477535] Starting dynamic subtest: rcs0 [336.573522] Dynamic subtest rcs0: SUCCESS (0.097s) [336.580754] Starting dynamic subtest: bcs0 [336.624951] Dynamic subtest bcs0: SUCCESS (0.050s) [336.647390] Starting dynamic subtest: vcs0 [336.690963] Dynamic subtest vcs0: SUCCESS (0.065s) [336.714794] Starting dynamic subtest: vcs1 [336.750081] Dynamic subtest vcs1: SUCCESS (0.058s) [336.772726] Starting dynamic subtest: vecs0 [336.825483] Dynamic subtest vecs0: SUCCESS (0.075s) [336.848370] Starting dynamic subtest: vecs1 [336.895963] Dynamic subtest vecs1: SUCCESS (0.070s) [336.919093] Starting dynamic subtest: ccs0 [336.960402] Dynamic subtest ccs0: SUCCESS (0.064s) [336.961231] Subtest cachelines: SUCCESS (0.484s) [337.208748] [067/130] (665s left) gem_exec_schedule (preempt-engines) [337.304701] Starting subtest: preempt-engines [337.305467] Starting dynamic subtest: rcs0 [339.507555] Dynamic subtest rcs0: SUCCESS (2.201s) [339.515934] Starting dynamic subtest: bcs0 [341.688362] Dynamic subtest bcs0: SUCCESS (2.180s) [341.696051] Starting dynamic subtest: vcs0 [343.989186] Dynamic subtest vcs0: SUCCESS (2.300s) [343.996248] Starting dynamic subtest: vcs1 [346.290827] Dynamic subtest vcs1: SUCCESS (2.300s) [346.300517] Starting dynamic subtest: vecs0 [348.591352] Dynamic subtest vecs0: SUCCESS (2.299s) [348.599139] Starting dynamic subtest: vecs1 [350.889339] Dynamic subtest vecs1: SUCCESS (2.297s) [350.897303] Starting dynamic subtest: ccs0 [353.076076] Dynamic subtest ccs0: SUCCESS (2.185s) [353.077671] Subtest preempt-engines: SUCCESS (15.770s) [353.398746] [068/130] (649s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [355.391380] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [355.392332] Starting dynamic subtest: pipe-A-HDMI-A-3 [356.686265] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.292s) [356.692406] Starting dynamic subtest: pipe-B-HDMI-A-3 [356.699772] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [356.706119] Starting dynamic subtest: pipe-C-HDMI-A-3 [356.713654] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.002s) [356.720648] Starting dynamic subtest: pipe-D-HDMI-A-3 [356.727864] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.003s) [356.728566] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SUCCESS (1.302s) [356.893891] [069/130] (645s left) gem_pread (bench) [356.946874] Subtest bench: SKIP (0.000s) [356.970762] [070/130] (645s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [358.983150] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [358.984889] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [359.063243] [071/130] (643s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [361.129571] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [361.131189] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [361.195418] [072/130] (641s left) gem_softpin (full) [361.292683] Starting subtest: full [361.319178] Subtest full: SUCCESS (0.026s) [361.432256] [073/130] (641s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [363.462404] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [363.464299] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [363.588628] [074/130] (639s left) kms_legacy_colorkey (invalid-plane) [365.619542] Starting subtest: invalid-plane [365.620494] Starting dynamic subtest: zero-id [365.621370] Dynamic subtest zero-id: SUCCESS (0.000s) [365.627695] Starting dynamic subtest: outrange-id [365.628504] Dynamic subtest outrange-id: SUCCESS (0.000s) [365.629319] Subtest invalid-plane: SUCCESS (0.001s) [365.669903] [075/130] (636s left) kms_cursor_crc (cursor-random-32x10) [367.751628] Starting subtest: cursor-random-32x10 [367.788243] Subtest cursor-random-32x10: SKIP (0.035s) [368.076971] [076/130] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [370.112805] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [370.114583] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [370.172046] [077/130] (632s left) gem_busy (parallel) [370.423349] Starting subtest: parallel [370.424382] Starting dynamic subtest: rcs0 [370.535427] Dynamic subtest rcs0: SUCCESS (0.112s) [370.548547] Starting dynamic subtest: bcs0 [370.598852] Dynamic subtest bcs0: SUCCESS (0.062s) [370.620986] Starting dynamic subtest: vcs0 [370.678742] Dynamic subtest vcs0: SUCCESS (0.079s) [370.692214] Starting dynamic subtest: vcs1 [370.744498] Dynamic subtest vcs1: SUCCESS (0.065s) [370.766978] Starting dynamic subtest: vecs0 [370.822872] Dynamic subtest vecs0: SUCCESS (0.078s) [370.834308] Starting dynamic subtest: vecs1 [370.884182] Dynamic subtest vecs1: SUCCESS (0.060s) [370.907170] Starting dynamic subtest: ccs0 [370.963047] Dynamic subtest ccs0: SUCCESS (0.078s) [370.964294] Subtest parallel: SUCCESS (0.540s) [371.163301] [078/130] (631s left) kms_big_fb (y-tiled-16bpp-rotate-270) [373.164578] Starting subtest: y-tiled-16bpp-rotate-270 [373.166364] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [373.240952] [079/130] (629s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [373.345351] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [373.346711] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [373.443640] [080/130] (629s left) kms_sequence (get-busy) [375.477381] Starting subtest: get-busy [375.478366] Starting dynamic subtest: pipe-A-HDMI-A-3 [377.961422] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.484s) [377.971463] Starting dynamic subtest: pipe-B-HDMI-A-3 [380.338363] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.376s) [380.346214] Starting dynamic subtest: pipe-C-HDMI-A-3 [382.717382] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.378s) [382.723893] Starting dynamic subtest: pipe-D-HDMI-A-3 [385.083811] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.366s) [385.084676] Subtest get-busy: SUCCESS (9.608s) [385.208438] [081/130] (617s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [387.209459] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s) [387.231760] [082/130] (615s left) gem_userptr_blits (stress-mm) [387.295653] Starting subtest: stress-mm [392.665717] Subtest stress-mm: SUCCESS (5.369s) [392.789867] [083/130] (610s left) gem_lmem_swapping (parallel-random-verify-ccs) [398.227241] Starting subtest: parallel-random-verify-ccs [398.228251] Starting dynamic subtest: lmem0 [462.575585] Dynamic subtest lmem0: SUCCESS (64.346s) [462.576411] Subtest parallel-random-verify-ccs: SUCCESS (64.347s) [464.428404] [084/130] (538s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [469.781624] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [469.782474] Starting dynamic subtest: pipe-A-HDMI-A-3 [469.791012] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [469.797070] Starting dynamic subtest: pipe-B-HDMI-A-3 [469.806212] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [469.811976] Starting dynamic subtest: pipe-C-HDMI-A-3 [469.820545] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [469.826717] Starting dynamic subtest: pipe-D-HDMI-A-3 [469.837168] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [469.838835] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.005s) [470.007722] [085/130] (532s left) kms_prop_blob (blob-prop-core) [470.097963] Starting subtest: blob-prop-core [470.098806] Subtest blob-prop-core: SUCCESS (0.000s) [470.196997] [086/130] (532s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [472.231992] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [474.833264] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.602s) [474.952981] [087/130] (527s left) gem_reg_read (timestamp-monotonic) [475.017268] Starting subtest: timestamp-monotonic [479.124136] Subtest timestamp-monotonic: SUCCESS (4.107s) [479.178217] [088/130] (523s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [481.178395] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [481.179947] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [481.248027] [089/130] (521s left) kms_big_fb (x-tiled-32bpp-rotate-270) [483.277417] Starting subtest: x-tiled-32bpp-rotate-270 [483.333673] Subtest x-tiled-32bpp-rotate-270: SKIP (0.056s) [483.450368] [090/130] (519s left) drm_fdinfo (busy-check-all) [483.546271] Starting subtest: busy-check-all [483.547218] Starting dynamic subtest: rcs0 [483.570174] Dynamic subtest rcs0: SKIP (0.023s) [483.576665] Starting dynamic subtest: bcs0 [483.578584] Dynamic subtest bcs0: SKIP (0.000s) [483.584677] Starting dynamic subtest: vcs0 [483.586842] Dynamic subtest vcs0: SKIP (0.000s) [483.593091] Starting dynamic subtest: vcs1 [483.595130] Dynamic subtest vcs1: SKIP (0.000s) [483.601477] Starting dynamic subtest: vecs0 [483.603543] Dynamic subtest vecs0: SKIP (0.000s) [483.609702] Starting dynamic subtest: vecs1 [483.611962] Dynamic subtest vecs1: SKIP (0.000s) [483.618935] Starting dynamic subtest: ccs0 [483.620954] Dynamic subtest ccs0: SKIP (0.000s) [483.623091] Subtest busy-check-all: SKIP (0.027s) [483.633268] [091/130] (519s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [485.680619] Starting subtest: fbc-rgb565-draw-mmap-gtt [485.682209] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [485.768585] [092/130] (517s left) kms_vblank (wait-forked-busy) [487.823499] Starting subtest: wait-forked-busy [487.824442] Starting dynamic subtest: pipe-A-HDMI-A-3 [490.272398] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.448s) [490.283194] Starting dynamic subtest: pipe-D-HDMI-A-3 [492.650122] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.373s) [492.651178] Subtest wait-forked-busy: SUCCESS (4.826s) [492.745437] [093/130] (510s left) gem_exec_params (invalid-bsd2-flag-on-blt) [492.821468] Starting subtest: invalid-bsd2-flag-on-blt [492.822336] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [492.928252] [094/130] (510s left) prime_self_import (basic-with_fd_dup) [492.965728] Starting subtest: basic-with_fd_dup [492.974872] Subtest basic-with_fd_dup: SUCCESS (0.010s) [493.096988] [095/130] (509s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [493.177154] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [493.178116] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [493.262901] [096/130] (509s left) gem_eio (in-flight-1us) [493.517221] Starting subtest: in-flight-1us [498.094406] Subtest in-flight-1us: SUCCESS (4.578s) [500.097556] [097/130] (503s left) kms_feature_discovery (psr1) [502.122884] Starting subtest: psr1 [502.124744] Subtest psr1: SKIP (0.000s) [502.180550] [098/130] (500s left) kms_flip (flip-vs-blocking-wf-vblank) [504.209495] Starting subtest: flip-vs-blocking-wf-vblank [504.214588] Starting dynamic subtest: A-HDMI-A3 [512.230516] Dynamic subtest A-HDMI-A3: SUCCESS (8.016s) [512.239658] Starting dynamic subtest: B-HDMI-A3 [520.172816] Dynamic subtest B-HDMI-A3: SUCCESS (7.941s) [520.180313] Starting dynamic subtest: C-HDMI-A3 [528.113724] Dynamic subtest C-HDMI-A3: SUCCESS (7.940s) [528.121153] Starting dynamic subtest: D-HDMI-A3 [536.055180] Dynamic subtest D-HDMI-A3: SUCCESS (7.941s) [536.056148] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.847s) [536.212844] [099/130] (466s left) kms_psr (psr2-basic) [538.211166] Subtest psr2-basic: SKIP (0.000s) [538.238747] [100/130] (464s left) kms_big_fb (linear-64bpp-rotate-90) [540.249285] Starting subtest: linear-64bpp-rotate-90 [540.295993] Subtest linear-64bpp-rotate-90: SKIP (0.046s) [540.413332] [101/130] (462s left) i915_pm_rpm (system-suspend-devices) [545.473790] Starting subtest: system-suspend-devices [553.917911] Subtest system-suspend-devices: SUCCESS (8.443s) [557.075667] [102/130] (448s left) gem_userptr_blits (huge-split) [557.140486] Starting subtest: huge-split [557.164408] Subtest huge-split: SUCCESS (0.024s) [557.282822] [103/130] (447s left) gem_ctx_persistence (heartbeat-many) [557.339196] Starting subtest: heartbeat-many [557.340882] Subtest heartbeat-many: SKIP (0.000s) [557.454262] [104/130] (447s left) gem_mmap_gtt (basic-small-bo-tiledy) [557.512191] Subtest basic-small-bo-tiledY: SKIP (0.000s) [557.546490] [105/130] (447s left) kms_plane (planar-pixel-format-settings) [559.542660] Starting subtest: planar-pixel-format-settings [559.581431] Subtest planar-pixel-format-settings: SUCCESS (0.040s) [559.678659] [106/130] (445s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [559.801780] Starting subtest: yf-tiled-to-vebox-y-tiled [559.804103] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [559.998714] [107/130] (445s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [562.021199] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [562.022247] Starting dynamic subtest: pipe-A [562.118954] Dynamic subtest pipe-A: SUCCESS (0.097s) [562.134160] Starting dynamic subtest: pipe-B [562.283069] Dynamic subtest pipe-B: SUCCESS (0.163s) [562.294019] Starting dynamic subtest: pipe-C [562.406497] Dynamic subtest pipe-C: SUCCESS (0.123s) [562.416166] Starting dynamic subtest: pipe-D [562.529236] Dynamic subtest pipe-D: SUCCESS (0.122s) [562.530174] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.508s) [562.655308] [108/130] (442s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [564.663100] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [564.664902] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [564.735813] [109/130] (440s left) kms_atomic (plane-invalid-params) [566.799439] Starting subtest: plane-invalid-params [566.804092] Starting dynamic subtest: pipe-A-HDMI-A-3 [567.689718] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.887s) [567.690629] Subtest plane-invalid-params: SUCCESS (0.892s) [567.823952] [110/130] (437s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [569.833203] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [569.852845] [111/130] (435s left) kms_scaling_modes (scaling-mode-none) [571.860670] Starting subtest: scaling-mode-none [571.862540] Subtest scaling-mode-none: SKIP (0.001s) [571.926573] [112/130] (433s left) kms_flip (2x-flip-vs-wf_vblank) [573.948127] Starting subtest: 2x-flip-vs-wf_vblank [573.963198] Subtest 2x-flip-vs-wf_vblank: SKIP (0.015s) [574.024931] [113/130] (431s left) kms_psr (psr2-sprite-mmap-gtt) [576.033698] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s) [576.052201] [114/130] (429s left) gem_mmap_gtt (hang-user) [576.103114] Subtest hang-user: SKIP (0.000s) [576.136729] [115/130] (429s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [578.168836] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [578.170526] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [578.265987] [116/130] (427s left) kms_draw_crc (draw-method-mmap-cpu) [580.341522] Starting subtest: draw-method-mmap-cpu [580.342418] Starting dynamic subtest: xrgb8888-untiled [580.642888] Dynamic subtest xrgb8888-untiled: SUCCESS (0.301s) [580.670926] Starting dynamic subtest: rgb565-untiled [580.943059] Dynamic subtest rgb565-untiled: SUCCESS (0.298s) [580.972646] Starting dynamic subtest: xrgb2101010-untiled [581.241910] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.298s) [581.250929] Starting dynamic subtest: xrgb8888-xtiled [581.392906] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.150s) [581.408100] Starting dynamic subtest: rgb565-xtiled [581.543115] Dynamic subtest rgb565-xtiled: SUCCESS (0.148s) [581.553667] Starting dynamic subtest: xrgb2101010-xtiled [581.676064] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s) [581.706833] Starting dynamic subtest: xrgb8888-4tiled [581.859845] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.182s) [581.870826] Starting dynamic subtest: rgb565-4tiled [582.008762] Dynamic subtest rgb565-4tiled: SUCCESS (0.148s) [582.020999] Starting dynamic subtest: xrgb2101010-4tiled [582.159334] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.149s) [582.160879] Subtest draw-method-mmap-cpu: SUCCESS (1.819s) [582.295052] [117/130] (423s left) gem_exec_reloc (basic-wc-gtt-noreloc) [582.356282] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [582.404641] [118/130] (423s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [584.400228] Starting subtest: flip-vs-cursor-busy-crc-legacy [585.184444] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.779s) [585.320958] [119/130] (420s left) syncobj_wait (invalid-signal-bad-pad) [585.383413] Starting subtest: invalid-signal-bad-pad [585.384374] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [585.518429] [120/130] (420s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [587.536549] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [587.538419] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [587.624391] [121/130] (418s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [589.743277] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [589.806781] [122/130] (415s left) gem_exec_reloc (basic-gtt-active) [589.891664] Subtest basic-gtt-active: SKIP (0.000s) [589.941442] [123/130] (415s left) sw_sync (sync_merge_invalid) [590.010606] Starting subtest: sync_merge_invalid [590.020425] Subtest sync_merge_invalid: SUCCESS (0.010s) [590.081651] [124/130] (415s left) kms_display_modes (mst-extended-mode-negative) [592.090805] Starting subtest: mst-extended-mode-negative [592.092960] Subtest mst-extended-mode-negative: SKIP (0.000s) [592.132490] [125/130] (413s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [594.126491] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [594.127339] Starting dynamic subtest: pipe-A-valid-mode [594.972089] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.844s) [594.973071] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.845s) [595.127655] [126/130] (410s left) gem_ctx_param (set-priority-range) [595.195455] Starting subtest: set-priority-range [595.207520] Subtest set-priority-range: SUCCESS (0.012s) [595.308654] [127/130] (410s left) gem_exec_fair (basic-flow) [595.376808] Subtest basic-flow: SKIP (0.000s) [595.418241] [128/130] (410s left) gem_mmap_gtt (medium-copy) [595.469544] Subtest medium-copy: SKIP (0.000s) [595.501508] [129/130] (410s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [597.493744] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [597.494662] Starting dynamic subtest: pipe-A-HDMI-A-3 [605.661394] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.164s) [605.672684] Starting dynamic subtest: pipe-B-HDMI-A-3 [606.337568] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.672s) [606.350195] Starting dynamic subtest: pipe-C-HDMI-A-3 [607.010518] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.668s) [607.023180] Starting dynamic subtest: pipe-D-HDMI-A-3 [607.685061] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.669s) [607.686760] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SUCCESS (10.187s) [607.869118] [130/130] (398s left) gem_exec_reloc (basic-wc-noreloc) [607.936497] Subtest basic-wc-noreloc: SKIP (0.000s) [607.975587] Closing watchdogs Done.