[62.393879] Initializing watchdogs [62.393944] /dev/watchdog0 [62.401631] [001/130] (960s left) gem_sync (basic-store-each) [62.487976] Starting subtest: basic-store-each [65.400345] Subtest basic-store-each: SUCCESS (2.910s) [65.639317] [002/130] (957s left) perf_pmu (init-busy) [65.720496] Starting subtest: init-busy [65.721444] Starting dynamic subtest: rcs0 [65.723437] Dynamic subtest rcs0: SUCCESS (0.002s) [65.729641] Starting dynamic subtest: bcs0 [65.730816] Dynamic subtest bcs0: SUCCESS (0.001s) [65.736936] Starting dynamic subtest: vcs0 [65.738233] Dynamic subtest vcs0: SUCCESS (0.000s) [65.744493] Starting dynamic subtest: vcs1 [65.745575] Dynamic subtest vcs1: SUCCESS (0.000s) [65.751632] Starting dynamic subtest: vecs0 [65.752818] Dynamic subtest vecs0: SUCCESS (0.000s) [65.758952] Starting dynamic subtest: vecs1 [65.760268] Dynamic subtest vecs1: SUCCESS (0.000s) [65.766381] Starting dynamic subtest: ccs0 [65.767628] Dynamic subtest ccs0: SUCCESS (0.000s) [65.768778] Subtest init-busy: SUCCESS (0.005s) [65.805261] [003/130] (957s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [65.880287] Starting subtest: invalid-multi-wait-unsubmitted-submitted [65.881205] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [65.985519] [004/130] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [68.027455] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [68.029337] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [68.272357] [005/130] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [70.329539] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [70.331245] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [70.412665] [006/130] (952s left) i915_pm_rc6_residency (rc6-idle) [70.579991] Starting subtest: rc6-idle [70.594670] Starting dynamic subtest: gt0-rcs0 [82.820950] Dynamic subtest gt0-rcs0: SUCCESS (12.222s) [82.827996] Starting dynamic subtest: gt0-bcs0 [95.081663] Dynamic subtest gt0-bcs0: SUCCESS (12.259s) [95.088607] Starting dynamic subtest: gt0-vcs0 [107.342527] Dynamic subtest gt0-vcs0: SUCCESS (12.260s) [107.349655] Starting dynamic subtest: gt0-vecs0 [119.600355] Dynamic subtest gt0-vecs0: SUCCESS (12.257s) [119.607401] Starting dynamic subtest: gt0-ccs0 [131.857968] Dynamic subtest gt0-ccs0: SUCCESS (12.257s) [131.858973] Subtest rc6-idle: SUCCESS (61.270s) [131.952668] [007/130] (891s left) drm_fdinfo (virtual-busy-idle) [132.011142] Starting subtest: virtual-busy-idle [132.013180] Subtest virtual-busy-idle: SKIP (0.000s) [132.073545] [008/130] (891s left) gen9_exec_parse (valid-registers) [132.146175] Subtest valid-registers: SKIP (0.000s) [132.196170] [009/130] (890s left) i915_query (query-topology-known-pci-ids) [132.270084] Starting subtest: query-topology-known-pci-ids [132.272175] Subtest query-topology-known-pci-ids: SKIP (0.000s) [132.347441] [010/130] (890s left) syncobj_timeline (single-wait-for-submit-available-signaled) [132.453495] Starting subtest: single-wait-for-submit-available-signaled [132.454477] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [132.562461] [011/130] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [134.586106] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [134.587906] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [134.675271] [012/130] (888s left) sw_sync (timeline_closed_signaled) [134.826918] Starting subtest: timeline_closed_signaled [134.827848] Subtest timeline_closed_signaled: SUCCESS (0.000s) [134.866779] [013/130] (888s left) kms_psr (fbc-psr-basic) [136.880591] Subtest fbc-psr-basic: SKIP (0.000s) [136.913316] [014/130] (886s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [138.927023] Starting subtest: yf-tiled-16bpp-rotate-90 [138.929028] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [139.007013] [015/130] (884s left) gem_userptr_blits (relocations) [139.178276] Starting subtest: relocations [139.180058] Subtest relocations: SKIP (0.001s) [139.340694] [016/130] (883s left) syncobj_wait (invalid-reset-illegal-handle) [139.436023] Starting subtest: invalid-reset-illegal-handle [139.436975] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [139.537623] [017/130] (883s left) kms_psr (psr2-suspend) [141.544754] Subtest psr2-suspend: SKIP (0.000s) [141.563730] [018/130] (881s left) kms_lease (setcrtc-implicit-plane) [143.558230] Starting subtest: setcrtc-implicit-plane [143.559153] Starting dynamic subtest: pipe-A-HDMI-A-3 [143.978541] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.419s) [143.992230] Starting dynamic subtest: pipe-B-HDMI-A-3 [144.217871] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.238s) [144.225893] Starting dynamic subtest: pipe-C-HDMI-A-3 [144.444766] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.225s) [144.452649] Starting dynamic subtest: pipe-D-HDMI-A-3 [144.673622] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.228s) [144.674614] Subtest setcrtc-implicit-plane: SUCCESS (1.116s) [144.837424] [019/130] (878s left) kms_cursor_crc (cursor-size-change) [146.879199] Starting subtest: cursor-size-change [146.880150] Starting dynamic subtest: pipe-A-HDMI-A-3 [147.821596] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.941s) [147.830165] Starting dynamic subtest: pipe-D-HDMI-A-3 [148.536063] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.713s) [148.537040] Subtest cursor-size-change: SUCCESS (1.656s) [148.966323] [020/130] (874s left) kms_joiner (invalid-modeset-force-ultra-joiner) [150.985500] Starting subtest: invalid-modeset-force-ultra-joiner [150.987297] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [151.049786] [021/130] (872s left) kms_dp_aux_dev [152.641190] [022/130] (870s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [154.651560] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [154.653274] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [154.735730] [023/130] (868s left) kms_pm_rpm (modeset-stress-extra-wait) [159.011572] Starting subtest: modeset-stress-extra-wait [212.145820] Subtest modeset-stress-extra-wait: SUCCESS (53.133s) [212.239371] [024/130] (811s left) gem_render_copy (y-tiled-to-vebox-linear) [212.312248] Starting subtest: y-tiled-to-vebox-linear [212.314578] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [212.550686] [025/130] (810s left) gem_exec_schedule (semaphore-power) [212.803977] Subtest semaphore-power: SKIP (0.000s) [213.000963] [026/130] (810s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [215.051724] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [215.053552] Starting dynamic subtest: pipe-A-HDMI-A-3 [215.070322] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [215.095100] Starting dynamic subtest: pipe-B-HDMI-A-3 [215.106540] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [215.118518] Starting dynamic subtest: pipe-C-HDMI-A-3 [215.127975] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [215.136810] Starting dynamic subtest: pipe-D-HDMI-A-3 [215.145769] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [215.147422] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.016s) [215.285397] [027/130] (808s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [217.308417] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [217.310391] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [217.426750] [028/130] (806s left) prime_vgem (fence-flip-hang) [217.716073] Subtest fence-flip-hang: SKIP (0.000s) [217.845952] [029/130] (805s left) syncobj_eventfd (binary-wait) [217.941623] Starting subtest: binary-wait [217.951964] Subtest binary-wait: SUCCESS (0.010s) [218.043509] [030/130] (805s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [220.080173] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [220.081044] Starting dynamic subtest: pipe-A-valid-mode [220.129230] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s) [220.130984] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.047s) [220.219246] [031/130] (803s left) kms_plane_scaling (planes-downscale-factor-0-75) [222.305167] Starting subtest: planes-downscale-factor-0-75 [222.306138] Starting dynamic subtest: pipe-A [222.401670] Dynamic subtest pipe-A: SUCCESS (0.097s) [222.412582] Starting dynamic subtest: pipe-B [222.550074] Dynamic subtest pipe-B: SUCCESS (0.148s) [222.574885] Starting dynamic subtest: pipe-C [222.724590] Dynamic subtest pipe-C: SUCCESS (0.175s) [222.732281] Starting dynamic subtest: pipe-D [222.849496] Dynamic subtest pipe-D: SUCCESS (0.125s) [222.850456] Subtest planes-downscale-factor-0-75: SUCCESS (0.545s) [223.050337] [032/130] (800s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [225.107501] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [225.109284] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [225.207506] [033/130] (798s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [227.326940] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [230.216493] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.890s) [230.346935] [034/130] (793s left) gem_ctx_exec (basic-close-race) [230.425531] Starting subtest: basic-close-race [236.006959] Subtest basic-close-race: SUCCESS (5.581s) [236.146475] [035/130] (787s left) kms_flip (2x-plain-flip-fb-recreate) [238.201194] Starting subtest: 2x-plain-flip-fb-recreate [238.214162] Subtest 2x-plain-flip-fb-recreate: SKIP (0.013s) [238.283742] [036/130] (785s left) kms_big_fb (4-tiled-64bpp-rotate-270) [240.377373] Starting subtest: 4-tiled-64bpp-rotate-270 [240.433401] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.056s) [240.590854] [037/130] (783s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [242.666078] Starting subtest: psr-rgb101010-draw-mmap-gtt [242.667811] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [242.755766] [038/130] (781s left) gem_ctx_isolation (preservation) [242.936592] Starting subtest: preservation [242.937496] Starting dynamic subtest: rcs0 [243.335309] Dynamic subtest rcs0: SUCCESS (0.398s) [243.343122] Starting dynamic subtest: bcs0 [243.773043] Dynamic subtest bcs0: SUCCESS (0.437s) [243.781051] Starting dynamic subtest: vcs0 [244.209736] Dynamic subtest vcs0: SUCCESS (0.436s) [244.217239] Starting dynamic subtest: vcs1 [244.612213] Dynamic subtest vcs1: SUCCESS (0.402s) [244.619505] Starting dynamic subtest: vecs0 [245.015660] Dynamic subtest vecs0: SUCCESS (0.403s) [245.023377] Starting dynamic subtest: vecs1 [245.448367] Dynamic subtest vecs1: SUCCESS (0.433s) [245.455796] Starting dynamic subtest: ccs0 [245.870853] Dynamic subtest ccs0: SUCCESS (0.422s) [245.871776] Subtest preservation: SUCCESS (2.934s) [246.135173] [039/130] (777s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [248.156196] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [248.158124] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [248.301959] [040/130] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [250.378870] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [250.380550] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [250.492205] [041/130] (773s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [252.604250] Starting subtest: 2x-cursor-vs-flip-atomic [252.607430] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s) [252.667290] [042/130] (771s left) syncobj_timeline (wait-any-interrupted) [252.816913] Starting subtest: wait-any-interrupted [252.919614] Subtest wait-any-interrupted: SUCCESS (0.102s) [253.024418] [043/130] (771s left) kms_psr (psr-primary-blt) [255.068522] Subtest psr-primary-blt: SKIP (0.000s) [255.093600] [044/130] (769s left) i915_pm_rpm (system-suspend-devices) [260.084066] Starting subtest: system-suspend-devices [268.748220] Subtest system-suspend-devices: SUCCESS (8.664s) [273.011188] [045/130] (754s left) kms_frontbuffer_tracking (fbc-suspend) [275.030181] Starting subtest: fbc-suspend [316.820774] Subtest fbc-suspend: SUCCESS (10.590s) [317.998600] [046/130] (741s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [320.016757] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [320.017714] Starting dynamic subtest: pipe-A-HDMI-A-3 [328.310939] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (8.288s) [328.324711] Starting dynamic subtest: pipe-B-HDMI-A-3 [329.020590] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.706s) [329.053978] Starting dynamic subtest: pipe-C-HDMI-A-3 [329.762569] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.737s) [329.796630] Starting dynamic subtest: pipe-D-HDMI-A-3 [330.503747] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.736s) [330.505577] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SUCCESS (10.483s) [330.737637] [047/130] (728s left) gem_sync (basic-store-all) [330.834657] Starting subtest: basic-store-all [335.551684] Subtest basic-store-all: SUCCESS (4.700s) [335.730340] [048/130] (723s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt) [337.507405] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt [337.509345] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [337.595837] [049/130] (722s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [339.458147] Starting subtest: cursorA-vs-flipB-atomic [339.459964] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [339.526901] [050/130] (720s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [341.379019] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [341.379869] Starting dynamic subtest: pipe-A-valid-mode [342.824309] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.421s) [342.825475] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.422s) [342.977626] [051/130] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [344.963826] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [344.965629] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [345.057618] [052/130] (714s left) gem_mmap_gtt (basic-read-write) [345.233427] Subtest basic-read-write: SKIP (0.000s) [345.278962] [053/130] (714s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [345.364548] Starting subtest: x-tiled-to-vebox-y-tiled [345.366531] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [345.552185] [054/130] (714s left) kms_prop_blob (blob-prop-lifetime) [345.621525] Starting subtest: blob-prop-lifetime [345.622409] Subtest blob-prop-lifetime: SUCCESS (0.001s) [345.714600] [055/130] (714s left) kms_plane (plane-position-covered) [347.741919] Starting subtest: plane-position-covered [348.159931] Starting dynamic subtest: pipe-A-plane-1 [348.550137] Dynamic subtest pipe-A-plane-1: SUCCESS (0.387s) [348.566555] Starting dynamic subtest: pipe-A-plane-2 [348.940671] Dynamic subtest pipe-A-plane-2: SUCCESS (0.387s) [348.955124] Starting dynamic subtest: pipe-A-plane-3 [349.321403] Dynamic subtest pipe-A-plane-3: SUCCESS (0.378s) [349.331013] Starting dynamic subtest: pipe-A-plane-4 [349.695958] Dynamic subtest pipe-A-plane-4: SUCCESS (0.372s) [349.706100] Starting dynamic subtest: pipe-A-plane-5 [349.711482] Dynamic subtest pipe-A-plane-5: SUCCESS (0.015s) [349.981796] Starting dynamic subtest: pipe-B-plane-1 [350.329246] Dynamic subtest pipe-B-plane-1: SUCCESS (0.356s) [350.339065] Starting dynamic subtest: pipe-B-plane-2 [350.687536] Dynamic subtest pipe-B-plane-2: SUCCESS (0.356s) [350.699329] Starting dynamic subtest: pipe-B-plane-3 [351.032533] Dynamic subtest pipe-B-plane-3: SUCCESS (0.342s) [351.043383] Starting dynamic subtest: pipe-B-plane-4 [351.379690] Dynamic subtest pipe-B-plane-4: SUCCESS (0.345s) [351.390205] Starting dynamic subtest: pipe-B-plane-5 [351.395851] Dynamic subtest pipe-B-plane-5: SUCCESS (0.015s) [351.396759] Subtest plane-position-covered: SUCCESS (3.631s) [351.516563] [056/130] (708s left) gem_pread (self) [351.602685] Subtest self: SKIP (0.000s) [351.651209] [057/130] (708s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [351.732073] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [351.849356] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [351.905087] [058/130] (708s left) gem_ctx_shared (q-in-order) [351.987420] Starting subtest: Q-in-order [351.988404] Starting dynamic subtest: rcs0 [352.241560] Dynamic subtest rcs0: SUCCESS (0.252s) [352.251957] Starting dynamic subtest: bcs0 [352.419469] Dynamic subtest bcs0: SUCCESS (0.177s) [352.429934] Starting dynamic subtest: vcs0 [352.599397] Dynamic subtest vcs0: SUCCESS (0.178s) [352.609976] Starting dynamic subtest: vcs1 [352.778149] Dynamic subtest vcs1: SUCCESS (0.177s) [352.788644] Starting dynamic subtest: vecs0 [352.957224] Dynamic subtest vecs0: SUCCESS (0.178s) [352.967871] Starting dynamic subtest: vecs1 [353.140451] Dynamic subtest vecs1: SUCCESS (0.182s) [353.151449] Starting dynamic subtest: ccs0 [353.325328] Dynamic subtest ccs0: SUCCESS (0.184s) [353.326154] Subtest Q-in-order: SUCCESS (1.332s) [353.624135] [059/130] (706s left) gem_ctx_shared (single-timeline) [353.715347] Starting subtest: single-timeline [353.746823] Subtest single-timeline: SUCCESS (0.028s) [354.000906] [060/130] (706s left) kms_properties (invalid-properties-atomic) [356.012937] Starting subtest: invalid-properties-atomic [356.375432] Subtest invalid-properties-atomic: SUCCESS (0.362s) [356.438465] [061/130] (703s left) gem_exec_reloc (basic-wc-read) [356.526701] Subtest basic-wc-read: SKIP (0.000s) [356.584723] [062/130] (703s left) kms_content_protection (legacy) [358.672577] Starting subtest: legacy [359.998064] Subtest legacy: SKIP (1.317s) [360.216703] [063/130] (700s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [362.244082] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [362.245069] Starting dynamic subtest: pipe-A-HDMI-A-3 [381.681553] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.918s) [381.701655] Starting dynamic subtest: pipe-B-HDMI-A-3 [401.668767] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (3.607s) [401.680310] Starting dynamic subtest: pipe-C-HDMI-A-3 [421.665094] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (3.706s) [421.675251] Starting dynamic subtest: pipe-D-HDMI-A-3 [440.660963] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.596s) [440.662008] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SUCCESS (14.833s) [444.954525] [064/130] (682s left) kms_chamelium_frames (dp-frame-dump) [447.018366] Subtest dp-frame-dump: SKIP (0.000s) [447.079995] [065/130] (680s left) gem_partial_pwrite_pread (reads-uncached) [447.177957] Subtest reads-uncached: SKIP (0.000s) [447.232516] [066/130] (680s left) kms_psr (pr-primary-render) [449.262643] Subtest pr-primary-render: SKIP (0.000s) [449.296165] [067/130] (678s left) kms_vblank (ts-continuation-modeset-hang) [451.282818] Starting subtest: ts-continuation-modeset-hang [451.283738] Starting dynamic subtest: pipe-A-HDMI-A-3 [477.371092] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (25.790s) [477.382806] Starting dynamic subtest: pipe-D-HDMI-A-3 [502.296037] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.910s) [502.296967] Subtest ts-continuation-modeset-hang: SUCCESS (50.706s) [502.405937] [068/130] (625s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [504.436746] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [504.438435] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [504.560799] [069/130] (623s left) gem_exec_basic (basic) [504.731073] Starting subtest: basic [504.732020] Starting dynamic subtest: rcs0-smem [504.734088] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [504.744381] Starting dynamic subtest: bcs0-smem [504.745332] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [504.755362] Starting dynamic subtest: vcs0-smem [504.756474] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [504.766231] Starting dynamic subtest: vcs1-smem [504.767358] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [504.776822] Starting dynamic subtest: vecs0-smem [504.777988] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [504.787363] Starting dynamic subtest: vecs1-smem [504.788481] Dynamic subtest vecs1-smem: SUCCESS (0.000s) [504.797988] Starting dynamic subtest: ccs0-smem [504.799109] Dynamic subtest ccs0-smem: SUCCESS (0.000s) [504.808372] Starting dynamic subtest: rcs0-lmem0 [504.809495] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s) [504.818812] Starting dynamic subtest: bcs0-lmem0 [504.819998] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [504.829347] Starting dynamic subtest: vcs0-lmem0 [504.830441] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [504.840007] Starting dynamic subtest: vcs1-lmem0 [504.841128] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [504.850455] Starting dynamic subtest: vecs0-lmem0 [504.851339] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [504.861036] Starting dynamic subtest: vecs1-lmem0 [504.862118] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s) [504.871957] Starting dynamic subtest: ccs0-lmem0 [504.873126] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s) [504.874136] Subtest basic: SUCCESS (0.017s) [504.920491] [070/130] (623s left) gem_vm_create (invalid-create) [505.000011] Starting subtest: invalid-create [505.003503] Subtest invalid-create: SUCCESS (0.003s) [505.136525] [071/130] (623s left) gem_exec_params (rel-constants-invalid) [505.220062] Starting subtest: rel-constants-invalid [505.221029] Subtest rel-constants-invalid: SUCCESS (0.000s) [505.355420] [072/130] (623s left) syncobj_wait (invalid-signal-zero-handles) [505.450395] Starting subtest: invalid-signal-zero-handles [505.451350] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [505.586504] [073/130] (622s left) syncobj_wait (multi-wait-all-signaled) [505.663209] Starting subtest: multi-wait-all-signaled [505.664077] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [505.785515] [074/130] (622s left) gem_partial_pwrite_pread (write) [505.871843] Subtest write: SKIP (0.000s) [505.916525] [075/130] (622s left) api_intel_allocator (fork-simple-stress) [505.988912] Starting subtest: fork-simple-stress [511.420843] Subtest fork-simple-stress: SUCCESS (5.429s) [511.493252] [076/130] (617s left) kms_cursor_crc (cursor-sliding-32x10) [513.636751] Starting subtest: cursor-sliding-32x10 [513.681223] Subtest cursor-sliding-32x10: SKIP (0.042s) [513.967379] [077/130] (614s left) gem_mmap_gtt (basic) [514.067549] Subtest basic: SKIP (0.000s) [514.105511] [078/130] (614s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [516.129583] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [516.130521] Starting dynamic subtest: pipe-A-HDMI-A-3 [522.427427] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.295s) [522.446681] Starting dynamic subtest: pipe-B-HDMI-A-3 [523.921286] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.487s) [523.965245] Starting dynamic subtest: pipe-C-HDMI-A-3 [525.480354] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.551s) [525.524296] Starting dynamic subtest: pipe-D-HDMI-A-3 [527.023391] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.535s) [527.025461] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (10.892s) [527.266855] [079/130] (601s left) gem_eio (wait-10ms) [527.570115] Starting subtest: wait-10ms [528.169773] Subtest wait-10ms: SUCCESS (0.600s) [530.188133] [080/130] (598s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [532.329556] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [532.331396] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [532.431041] [081/130] (596s left) kms_scaling_modes (scaling-mode-full) [534.554820] Starting subtest: scaling-mode-full [534.556709] Subtest scaling-mode-full: SKIP (0.001s) [534.622455] [082/130] (594s left) syncobj_timeline (host-signal-ordered) [534.776152] Starting subtest: host-signal-ordered [534.777042] Subtest host-signal-ordered: SUCCESS (0.000s) [534.915387] [083/130] (593s left) gem_userptr_blits (sync-overlap) [535.016074] Starting subtest: sync-overlap [535.017003] Subtest sync-overlap: SUCCESS (0.000s) [535.165842] [084/130] (593s left) gem_spin_batch (resubmit) [535.255983] Starting subtest: resubmit [535.256969] Starting dynamic subtest: rcs0 [535.279487] Dynamic subtest rcs0: SUCCESS (0.024s) [535.290752] Starting dynamic subtest: bcs0 [535.291784] Dynamic subtest bcs0: SUCCESS (0.003s) [535.302881] Starting dynamic subtest: vcs0 [535.304072] Dynamic subtest vcs0: SUCCESS (0.003s) [535.314938] Starting dynamic subtest: vcs1 [535.316128] Dynamic subtest vcs1: SUCCESS (0.002s) [535.326951] Starting dynamic subtest: vecs0 [535.327924] Dynamic subtest vecs0: SUCCESS (0.002s) [535.338084] Starting dynamic subtest: vecs1 [535.338998] Dynamic subtest vecs1: SUCCESS (0.002s) [535.349341] Starting dynamic subtest: ccs0 [535.350465] Dynamic subtest ccs0: SUCCESS (0.002s) [535.351632] Subtest resubmit: SUCCESS (0.044s) [535.561459] [085/130] (593s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [537.596587] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [537.598362] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [537.701794] [086/130] (591s left) kms_vrr (seamless-rr-switch-vrr) [539.826751] Starting subtest: seamless-rr-switch-vrr [539.829475] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [539.891319] [087/130] (589s left) kms_psr (fbc-psr2-cursor-blt) [541.992000] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [542.018121] [088/130] (587s left) kms_psr (fbc-pr-cursor-render) [544.021023] Subtest fbc-pr-cursor-render: SKIP (0.000s) [544.052196] [089/130] (585s left) gem_exec_whisper (basic-queues-priority-all) [544.140755] Starting subtest: basic-queues-priority-all [566.081163] Subtest basic-queues-priority-all: SUCCESS (21.943s) [566.300050] [090/130] (562s left) kms_big_fb (linear-32bpp-rotate-0) [568.340089] Starting subtest: linear-32bpp-rotate-0 [570.184897] Subtest linear-32bpp-rotate-0: SUCCESS (1.844s) [570.358826] [091/130] (558s left) gem_userptr_blits (readonly-unsync) [570.441141] Subtest readonly-unsync: SKIP (0.000s) [570.595777] [092/130] (558s left) sw_sync (sync_multi_producer_single_consumer) [570.666477] Starting subtest: sync_multi_producer_single_consumer [571.741422] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [571.785544] [093/130] (557s left) kms_chamelium_hpd (vga-hpd) [573.840009] Subtest vga-hpd: SKIP (0.000s) [573.904848] [094/130] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [575.945735] Starting subtest: psr-1p-primscrn-cur-indfb-move [575.947502] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [576.031641] [095/130] (553s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [578.148593] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [578.169334] [096/130] (551s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [580.175452] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [580.177230] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [580.300193] [097/130] (549s left) syncobj_timeline (multi-wait-all-signaled) [580.472432] Starting subtest: multi-wait-all-signaled [580.473331] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [580.604800] [098/130] (548s left) gem_busy (busy) [580.695964] Starting subtest: busy [580.696909] Starting dynamic subtest: all-engines [580.792029] Dynamic subtest all-engines: SUCCESS (0.095s) [580.804761] Starting dynamic subtest: rcs0 [580.874734] Dynamic subtest rcs0: SUCCESS (0.082s) [580.885886] Starting dynamic subtest: bcs0 [580.921122] Dynamic subtest bcs0: SUCCESS (0.045s) [580.937232] Starting dynamic subtest: vcs0 [580.960586] Dynamic subtest vcs0: SUCCESS (0.039s) [580.983707] Starting dynamic subtest: vcs1 [581.001592] Dynamic subtest vcs1: SUCCESS (0.040s) [581.023930] Starting dynamic subtest: vecs0 [581.042602] Dynamic subtest vecs0: SUCCESS (0.039s) [581.057856] Starting dynamic subtest: vecs1 [581.081678] Dynamic subtest vecs1: SUCCESS (0.038s) [581.108838] Starting dynamic subtest: ccs0 [581.122966] Dynamic subtest ccs0: SUCCESS (0.039s) [581.124248] Subtest busy: SUCCESS (0.427s) [581.526690] [099/130] (547s left) kms_pm_lpsp (kms-lpsp) [584.556735] Starting subtest: kms-lpsp [584.558552] Subtest kms-lpsp: SKIP (0.000s) [584.628170] [100/130] (544s left) gem_exec_balancer (individual) [584.795664] Starting subtest: individual [586.510924] Subtest individual: SUCCESS (1.715s) [586.877476] [101/130] (542s left) gem_softpin (evict-snoop) [586.965740] Starting subtest: evict-snoop [586.967604] Subtest evict-snoop: SKIP (0.000s) [587.026064] [102/130] (542s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [587.108960] Starting subtest: y-tiled-ccs-to-x-tiled [587.111051] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [587.303963] [103/130] (542s left) kms_hdr (static-toggle) [589.333875] Starting subtest: static-toggle [589.336708] Subtest static-toggle: SKIP (0.000s) [589.393793] [104/130] (540s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [591.494601] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [591.495512] Starting dynamic subtest: pipe-A-valid-mode [591.546527] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s) [591.548405] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.052s) [591.646251] [105/130] (538s left) perf_pmu (most-busy-check-all) [591.776683] Starting subtest: most-busy-check-all [591.777693] Starting dynamic subtest: rcs0 [592.367893] Dynamic subtest rcs0: SUCCESS (0.591s) [592.382810] Starting dynamic subtest: bcs0 [592.928370] Dynamic subtest bcs0: FAIL (0.534s) [592.941652] Starting dynamic subtest: vcs0 [593.448475] Dynamic subtest vcs0: FAIL (0.515s) [593.461064] Starting dynamic subtest: vcs1 [593.963801] Dynamic subtest vcs1: FAIL (0.515s) [593.976103] Starting dynamic subtest: vecs0 [594.478922] Dynamic subtest vecs0: FAIL (0.514s) [594.491308] Starting dynamic subtest: vecs1 [595.000648] Dynamic subtest vecs1: SUCCESS (0.549s) [595.012101] Starting dynamic subtest: ccs0 [595.554133] Dynamic subtest ccs0: SUCCESS (0.552s) [595.555036] Subtest most-busy-check-all: FAIL (3.777s) [595.663112] [106/130] (534s left) kms_big_fb (x-tiled-32bpp-rotate-90) [597.686807] Starting subtest: x-tiled-32bpp-rotate-90 [597.739777] Subtest x-tiled-32bpp-rotate-90: SKIP (0.052s) [597.895617] [107/130] (531s left) kms_big_fb (4-tiled-8bpp-rotate-180) [599.959699] Starting subtest: 4-tiled-8bpp-rotate-180 [601.440730] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.480s) [601.599723] [108/130] (528s left) syncobj_basic (bad-pad-handle-to-fd) [601.702088] Starting subtest: bad-pad-handle-to-fd [601.703022] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [601.851648] [109/130] (528s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [601.940963] Starting subtest: invalid-smem-bo-on-discrete [601.941874] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s) [603.987124] [110/130] (525s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [606.105615] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [606.107373] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [606.239743] [111/130] (523s left) kms_cursor_crc (cursor-random-128x128) [608.482613] Starting subtest: cursor-random-128x128 [608.487132] Starting dynamic subtest: pipe-A-HDMI-A-3 [613.000184] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.511s) [613.035069] Starting dynamic subtest: pipe-D-HDMI-A-3 [617.452975] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.427s) [617.453899] Subtest cursor-random-128x128: SUCCESS (8.969s) [617.744072] [112/130] (512s left) gem_exec_gttfill (engines) [617.840184] Starting subtest: engines [617.841062] Starting dynamic subtest: rcs0 [643.567057] Dynamic subtest rcs0: SUCCESS (25.719s) [643.580079] Starting dynamic subtest: bcs0 [669.237271] Dynamic subtest bcs0: SUCCESS (25.661s) [669.250072] Starting dynamic subtest: vcs0 [694.947062] Dynamic subtest vcs0: SUCCESS (25.713s) [694.959159] Starting dynamic subtest: vcs1 [720.687731] Dynamic subtest vcs1: SUCCESS (25.743s) [720.699248] Starting dynamic subtest: vecs0 [746.429036] Dynamic subtest vecs0: SUCCESS (25.741s) [746.440717] Starting dynamic subtest: vecs1 [772.184055] Dynamic subtest vecs1: SUCCESS (25.752s) [772.196064] Starting dynamic subtest: ccs0 [797.861967] Dynamic subtest ccs0: SUCCESS (25.673s) [797.862832] Subtest engines: SUCCESS (180.009s) [798.074356] [113/130] (332s left) gem_exec_schedule (noreorder-priority) [798.343910] Starting subtest: noreorder-priority [798.344837] Starting dynamic subtest: rcs0 [799.502044] Dynamic subtest rcs0: SUCCESS (1.157s) [799.515208] Starting dynamic subtest: bcs0 [800.641832] Dynamic subtest bcs0: SUCCESS (1.139s) [800.654350] Starting dynamic subtest: vcs0 [801.780952] Dynamic subtest vcs0: SUCCESS (1.138s) [801.794144] Starting dynamic subtest: vcs1 [802.939899] Dynamic subtest vcs1: SUCCESS (1.157s) [802.951679] Starting dynamic subtest: vecs0 [804.075011] Dynamic subtest vecs0: SUCCESS (1.134s) [804.088148] Starting dynamic subtest: vecs1 [805.222051] Dynamic subtest vecs1: SUCCESS (1.146s) [805.237898] Starting dynamic subtest: ccs0 [806.370900] Dynamic subtest ccs0: SUCCESS (1.147s) [806.371933] Subtest noreorder-priority: SUCCESS (8.026s) [806.579186] [114/130] (323s left) gem_mmap_offset (close-race) [806.650889] Starting subtest: close-race [826.715695] Subtest close-race: SUCCESS (20.061s) [826.857994] [115/130] (303s left) i915_query (hwconfig_table) [826.942938] Starting subtest: hwconfig_table [827.118251] Subtest hwconfig_table: SUCCESS (0.001s) [827.161151] [116/130] (303s left) kms_flip (plain-flip-ts-check) [829.189970] Starting subtest: plain-flip-ts-check [829.195938] Starting dynamic subtest: A-HDMI-A3 [837.253707] Dynamic subtest A-HDMI-A3: SUCCESS (8.055s) [837.269517] Starting dynamic subtest: B-HDMI-A3 [845.218270] Dynamic subtest B-HDMI-A3: SUCCESS (7.958s) [845.231729] Starting dynamic subtest: C-HDMI-A3 [853.170949] Dynamic subtest C-HDMI-A3: SUCCESS (7.949s) [853.186624] Starting dynamic subtest: D-HDMI-A3 [861.136633] Dynamic subtest D-HDMI-A3: SUCCESS (7.959s) [861.141351] Subtest plain-flip-ts-check: SUCCESS (31.941s) [861.326477] [117/130] (268s left) gem_eio (in-flight-10ms) [861.643991] Starting subtest: in-flight-10ms [866.827196] Subtest in-flight-10ms: SUCCESS (5.183s) [868.836230] [118/130] (261s left) kms_plane (pixel-format) [870.927715] Starting subtest: pixel-format [870.962716] Starting dynamic subtest: pipe-A-plane-0 [878.866278] Dynamic subtest pipe-A-plane-0: SUCCESS (7.901s) [878.911659] Starting dynamic subtest: pipe-A-plane-3 [883.298773] Dynamic subtest pipe-A-plane-3: SUCCESS (4.428s) [883.310742] Starting dynamic subtest: pipe-A-plane-5 [883.565989] Dynamic subtest pipe-A-plane-5: SUCCESS (0.266s) [883.711691] Starting dynamic subtest: pipe-B-plane-0 [891.535930] Dynamic subtest pipe-B-plane-0: SUCCESS (7.834s) [891.548565] Starting dynamic subtest: pipe-B-plane-3 [896.421537] Dynamic subtest pipe-B-plane-3: SUCCESS (4.882s) [896.468967] Starting dynamic subtest: pipe-B-plane-5 [896.654259] Dynamic subtest pipe-B-plane-5: SUCCESS (0.229s) [896.743185] Subtest pixel-format: SUCCESS (25.809s) [896.947254] [119/130] (233s left) api_intel_bb (misplaced-blitter) [897.040905] Starting subtest: misplaced-blitter [897.064671] Subtest misplaced-blitter: SUCCESS (0.024s) [897.224521] [120/130] (233s left) gem_exec_fence (submit-chain) [897.438168] Starting subtest: submit-chain [897.477086] Subtest submit-chain: SUCCESS (0.039s) [898.179471] [121/130] (232s left) prime_self_import (reimport-vs-gem_close-race) [898.245735] Starting subtest: reimport-vs-gem_close-race [903.308823] Subtest reimport-vs-gem_close-race: SUCCESS (5.063s) [903.376844] [122/130] (227s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [905.483625] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [905.485388] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [905.587455] [123/130] (224s left) perf_pmu (all-busy-check-all) [905.748890] Starting subtest: all-busy-check-all [906.322555] Subtest all-busy-check-all: SUCCESS (0.573s) [906.423064] [124/130] (224s left) kms_chamelium_color (ctm-blue-to-red) [908.446031] Subtest ctm-blue-to-red: SKIP (0.000s) [908.469919] [125/130] (222s left) kms_cursor_edge_walk (64x64-left-edge) [910.487871] Starting subtest: 64x64-left-edge [910.488802] Starting dynamic subtest: pipe-A-HDMI-A-3 [913.765901] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.276s) [913.779111] Starting dynamic subtest: pipe-D-HDMI-A-3 [916.976910] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.208s) [916.977957] Subtest 64x64-left-edge: SUCCESS (6.488s) [917.122377] [126/130] (213s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt) [919.141598] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt [919.143379] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [919.250860] [127/130] (211s left) gem_mmap_gtt (close-race) [919.428996] Subtest close-race: SKIP (0.000s) [919.466311] [128/130] (211s left) drm_fdinfo (context-close-stress) [919.537914] Starting subtest: context-close-stress [930.288758] Subtest context-close-stress: SUCCESS (10.748s) [930.358595] [129/130] (200s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [931.268175] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [931.269247] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [931.359713] [130/130] (199s left) gem_lmem_swapping (parallel-multi) [937.622087] Starting subtest: parallel-multi [937.623129] Starting dynamic subtest: lmem0 [994.543675] Dynamic subtest lmem0: SUCCESS (56.952s) [994.545003] Subtest parallel-multi: SUCCESS (56.954s) [996.488289] Closing watchdogs Done.