[57.409257] Initializing watchdogs [57.409386] /dev/watchdog0 [57.422655] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.426485] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.428465] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.431624] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [57.593199] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [57.597170] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [57.697411] [002/131] (960s left) gem_render_copy (yf-tiled) [57.762570] Starting subtest: yf-tiled [57.767151] Subtest yf-tiled: SKIP (0.000s) [57.935380] [003/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [58.033139] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [63.132211] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.102s) [63.257585] [004/131] (954s left) gem_ctx_sseu (engines) [63.327431] Subtest engines: SKIP (0.000s) [63.381042] [005/131] (954s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [63.481578] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [63.485808] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [63.557034] [006/131] (954s left) kms_psr (psr-primary-blt) [63.648083] Starting subtest: psr-primary-blt [63.650435] Starting dynamic subtest: eDP-1 [65.421671] Dynamic subtest eDP-1: SUCCESS (1.771s) [65.423980] Subtest psr-primary-blt: SUCCESS (1.772s) [66.263237] [007/131] (951s left) core_getstats [66.432517] [008/131] (951s left) perf_pmu (semaphore-busy) [66.471273] Starting subtest: semaphore-busy [66.473551] Starting dynamic subtest: rcs0 [68.135493] Dynamic subtest rcs0: SUCCESS (1.661s) [68.144197] Starting dynamic subtest: bcs0 [69.766493] Dynamic subtest bcs0: SUCCESS (1.631s) [69.775339] Starting dynamic subtest: vcs0 [73.447102] Dynamic subtest vcs0: SUCCESS (3.679s) [73.457844] Starting dynamic subtest: vcs1 [79.463072] Dynamic subtest vcs1: SUCCESS (6.016s) [79.471885] Starting dynamic subtest: vecs0 [85.413133] Dynamic subtest vecs0: SUCCESS (5.950s) [85.422334] Starting dynamic subtest: ccs0 [88.549865] Dynamic subtest ccs0: SUCCESS (3.137s) [88.552796] Subtest semaphore-busy: SUCCESS (22.077s) [88.656266] [009/131] (929s left) kms_rotation_crc (bad-pixel-format) [88.758544] Starting subtest: bad-pixel-format [88.762986] Subtest bad-pixel-format: SKIP (0.001s) [88.821165] [010/131] (929s left) syncobj_timeline (multi-wait-available-submitted) [88.872848] Starting subtest: multi-wait-available-submitted [88.874784] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [88.966651] [011/131] (929s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [93.910631] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [93.913075] Starting dynamic subtest: pipe-A-eDP-1 [94.712635] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s) [94.720819] Starting dynamic subtest: pipe-B-eDP-1 [95.835878] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s) [95.840464] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.922s) [96.999403] [012/131] (921s left) kms_psr (psr2-primary-page-flip) [97.104159] Starting subtest: psr2-primary-page-flip [97.110072] Starting dynamic subtest: eDP-1 [98.777202] Dynamic subtest eDP-1: SUCCESS (1.669s) [98.779247] Subtest psr2-primary-page-flip: SUCCESS (1.670s) [99.641656] [013/131] (918s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [99.760145] Starting subtest: flip-vs-cursor-varying-size [107.436124] Subtest flip-vs-cursor-varying-size: SUCCESS (7.677s) [108.262036] [014/131] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [108.367557] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [111.713709] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (3.351s) [111.817483] [015/131] (906s left) kms_psr2_su (page_flip-p010) [111.874878] Subtest page_flip-P010: SKIP (0.000s) [111.920698] [016/131] (906s left) kms_properties (plane-properties-legacy) [112.009255] Starting subtest: plane-properties-legacy [112.011134] Starting dynamic subtest: pipe-A-eDP-1 [112.599210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s) [112.607544] Starting dynamic subtest: pipe-B-eDP-1 [113.858517] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.261s) [113.865684] Starting dynamic subtest: pipe-C-eDP-1 [115.089044] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s) [115.097402] Starting dynamic subtest: pipe-D-eDP-1 [116.302890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s) [116.305436] Subtest plane-properties-legacy: SUCCESS (4.292s) [117.090197] [017/131] (901s left) kms_chamelium_color (degamma) [117.193493] Subtest degamma: SKIP (0.000s) [117.228183] [018/131] (901s left) gem_exec_schedule (fairslice) [117.302270] Starting subtest: fairslice [117.304621] Starting dynamic subtest: rcs0 [119.315374] Dynamic subtest rcs0: SUCCESS (2.018s) [119.324598] Starting dynamic subtest: bcs0 [121.335706] Dynamic subtest bcs0: SUCCESS (2.020s) [121.344919] Starting dynamic subtest: vcs0 [123.352472] Dynamic subtest vcs0: SUCCESS (2.018s) [123.360130] Starting dynamic subtest: vcs1 [125.371758] Dynamic subtest vcs1: SUCCESS (2.017s) [125.378921] Starting dynamic subtest: vecs0 [127.388328] Dynamic subtest vecs0: SUCCESS (2.018s) [127.396349] Starting dynamic subtest: ccs0 [129.408613] Dynamic subtest ccs0: SUCCESS (2.021s) [129.410487] Subtest fairslice: SUCCESS (12.114s) [129.703526] [019/131] (888s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [129.817256] Starting subtest: psr-rgb101010-draw-render [134.973272] Subtest psr-rgb101010-draw-render: SUCCESS (5.158s) [135.103062] [020/131] (883s left) kms_psr (fbc-pr-cursor-render) [135.202131] Starting subtest: fbc-pr-cursor-render [135.206495] Subtest fbc-pr-cursor-render: SKIP (0.000s) [135.267261] [021/131] (883s left) kms_setmode (basic-clone-single-crtc) [135.325997] Starting subtest: basic-clone-single-crtc [135.332851] Subtest basic-clone-single-crtc: SKIP (0.000s) [135.439903] [022/131] (883s left) gen9_exec_parse (secure-batches) [135.498796] Subtest secure-batches: SKIP (0.000s) [135.574647] [023/131] (883s left) kms_plane_scaling (planes-downscale-factor-0-75) [135.669597] Starting subtest: planes-downscale-factor-0-75 [135.671868] Starting dynamic subtest: pipe-A [135.691982] Dynamic subtest pipe-A: SKIP (0.015s) [135.701102] Starting dynamic subtest: pipe-B [135.715880] Dynamic subtest pipe-B: SKIP (0.025s) [135.724833] Starting dynamic subtest: pipe-C [135.742322] Dynamic subtest pipe-C: SKIP (0.026s) [135.749117] Starting dynamic subtest: pipe-D [135.767288] Dynamic subtest pipe-D: SKIP (0.025s) [135.770887] Subtest planes-downscale-factor-0-75: SKIP (0.092s) [135.860902] [024/131] (882s left) kms_invalid_mode (uint-max-clock) [135.964347] Starting subtest: uint-max-clock [135.966163] Starting dynamic subtest: pipe-A-eDP-1 [136.256803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [136.264058] Starting dynamic subtest: pipe-B-eDP-1 [136.265901] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [136.272104] Starting dynamic subtest: pipe-C-eDP-1 [136.273986] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [136.280647] Starting dynamic subtest: pipe-D-eDP-1 [136.282754] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [136.285033] Subtest uint-max-clock: SUCCESS (0.295s) [137.080177] [025/131] (881s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [137.191835] Starting subtest: yf-tiled-16bpp-rotate-270 [137.196154] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [137.304899] [026/131] (881s left) syncobj_wait (multi-wait-submitted) [137.359723] Starting subtest: multi-wait-submitted [137.463789] Subtest multi-wait-submitted: SUCCESS (0.102s) [137.531983] [027/131] (881s left) kms_chamelium_hpd (vga-hpd-after-suspend) [137.919280] Subtest vga-hpd-after-suspend: SKIP (0.000s) [138.678535] [028/131] (880s left) kms_plane_scaling (planes-upscale-factor-0-25) [138.779080] Starting subtest: planes-upscale-factor-0-25 [138.781537] Starting dynamic subtest: pipe-A [138.842644] Dynamic subtest pipe-A: SUCCESS (0.063s) [138.849730] Starting dynamic subtest: pipe-B [139.932463] Dynamic subtest pipe-B: SUCCESS (1.090s) [139.941552] Starting dynamic subtest: pipe-C [141.039865] Dynamic subtest pipe-C: SUCCESS (1.107s) [141.048790] Starting dynamic subtest: pipe-D [142.165423] Dynamic subtest pipe-D: SUCCESS (1.125s) [142.167793] Subtest planes-upscale-factor-0-25: SUCCESS (3.387s) [143.312268] [029/131] (875s left) gem_sync (basic-all) [143.391095] Starting subtest: basic-all [146.421652] Subtest basic-all: SUCCESS (3.040s) [146.595283] [030/131] (872s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [146.700124] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [146.704333] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [146.787340] [031/131] (872s left) prime_vgem (basic-fence-read) [146.894681] Starting subtest: basic-fence-read [146.906161] Subtest basic-fence-read: SKIP (0.009s) [147.011642] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [147.014583] [032/131] (871s left) gem_exec_schedule (u-independent) [147.090324] Starting subtest: u-independent [147.092350] Starting dynamic subtest: rcs0 [148.909739] Dynamic subtest rcs0: SUCCESS (1.828s) [148.920847] Starting dynamic subtest: vcs0 [150.997434] Dynamic subtest vcs0: SUCCESS (2.087s) [151.007784] Starting dynamic subtest: vcs1 [152.978728] Dynamic subtest vcs1: SUCCESS (1.980s) [152.986812] Starting dynamic subtest: vecs0 [154.961393] Dynamic subtest vecs0: SUCCESS (1.982s) [154.971487] Starting dynamic subtest: ccs0 [156.906966] Dynamic subtest ccs0: SUCCESS (1.945s) [156.909683] Subtest u-independent: SUCCESS (9.827s) [157.204796] [033/131] (861s left) gem_busy (semaphore) [157.396922] Subtest semaphore: SKIP (0.000s) [157.626211] [034/131] (861s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [157.729967] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [157.732297] Starting dynamic subtest: pipe-A-eDP-1 [157.741298] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [157.749881] Starting dynamic subtest: pipe-B-eDP-1 [157.758964] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [157.766316] Starting dynamic subtest: pipe-C-eDP-1 [157.775121] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [157.781839] Starting dynamic subtest: pipe-D-eDP-1 [157.790290] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [157.794621] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [159.861075] [035/131] (859s left) kms_plane_lowres (tiling-x) [159.953868] Starting subtest: tiling-x [159.956178] Starting dynamic subtest: pipe-A-eDP-1 [159.960843] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [160.248445] Starting dynamic subtest: pipe-B-eDP-1 [160.253660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [160.262942] Starting dynamic subtest: pipe-C-eDP-1 [160.267377] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [160.274123] Starting dynamic subtest: pipe-D-eDP-1 [160.278434] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [160.282794] Subtest tiling-x: SKIP (0.292s) [161.081774] [036/131] (857s left) kms_addfb_basic (unused-pitches) [161.134764] Starting subtest: unused-pitches [161.137352] Subtest unused-pitches: SUCCESS (0.000s) [161.270913] [037/131] (857s left) syncobj_wait (single-wait-all-for-submit-submitted) [161.321063] Starting subtest: single-wait-all-for-submit-submitted [161.422455] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s) [161.494541] [038/131] (857s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [161.603125] Starting subtest: plane-primary-toggle-with-vblank-wait [161.605466] Starting dynamic subtest: pipe-A-eDP-1 [161.789043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.183s) [162.098564] Starting dynamic subtest: pipe-B-eDP-1 [162.992694] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.901s) [163.283923] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.677s) [164.135773] [039/131] (854s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [164.232997] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [164.235437] Starting dynamic subtest: pipe-A-default-mode [164.533100] Dynamic subtest pipe-A-default-mode: SKIP (0.294s) [164.537827] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.295s) [165.369862] [040/131] (853s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [165.476651] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [169.194633] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.722s) [169.326750] [041/131] (849s left) kms_psr (fbc-psr-cursor-plane-onoff) [169.426706] Starting subtest: fbc-psr-cursor-plane-onoff [169.428535] Starting dynamic subtest: eDP-1 [169.432199] Dynamic subtest eDP-1: SKIP (0.000s) [169.435714] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [169.494110] [042/131] (849s left) kms_big_fb (x-tiled-64bpp-rotate-90) [169.592522] Starting subtest: x-tiled-64bpp-rotate-90 [169.613628] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s) [169.741935] [043/131] (849s left) kms_dp_link_training (non-uhbr-mst) [169.852075] Starting subtest: non-uhbr-mst [169.859657] Subtest non-uhbr-mst: SKIP (0.000s) [169.919351] [044/131] (849s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [170.019713] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [170.021733] Starting dynamic subtest: pipe-A-default-mode [170.310629] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [170.315370] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.286s) [171.112331] [045/131] (848s left) core_setmaster (master-drop-set-shared-fd) [173.047260] Starting subtest: master-drop-set-shared-fd [173.068995] Subtest master-drop-set-shared-fd: SUCCESS (0.023s) [173.096232] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.amdgpu: true [173.096919] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.xe: true [173.099983] [046/131] (846s left) gem_spin_batch (resubmit-new) [173.172551] Starting subtest: resubmit-new [173.174854] Starting dynamic subtest: rcs0 [173.181101] Dynamic subtest rcs0: SUCCESS (0.009s) [173.195941] Starting dynamic subtest: bcs0 [173.198340] Dynamic subtest bcs0: SUCCESS (0.004s) [173.205335] Starting dynamic subtest: vcs0 [173.207139] Dynamic subtest vcs0: SUCCESS (0.004s) [173.213657] Starting dynamic subtest: vcs1 [173.215546] Dynamic subtest vcs1: SUCCESS (0.004s) [173.221973] Starting dynamic subtest: vecs0 [173.223927] Dynamic subtest vecs0: SUCCESS (0.004s) [173.230245] Starting dynamic subtest: ccs0 [173.232156] Dynamic subtest ccs0: SUCCESS (0.003s) [173.234087] Subtest resubmit-new: SUCCESS (0.030s) [174.925815] [047/131] (844s left) gem_exec_balancer (full) [174.997347] Starting subtest: full [179.707682] Subtest full: SUCCESS (4.710s) [180.024506] [048/131] (839s left) kms_pm_rpm (modeset-lpsp-stress) [182.065022] Starting subtest: modeset-lpsp-stress [198.619572] Subtest modeset-lpsp-stress: SUCCESS (16.553s) [198.699204] [049/131] (820s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [198.795251] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [200.007728] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.214s) [200.383538] [050/131] (819s left) gem_lmem_swapping (heavy-random) [200.427539] Subtest heavy-random: SKIP (0.000s) [200.460288] [051/131] (819s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [200.565409] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [200.569795] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [200.676093] [052/131] (818s left) kms_lease (lease-invalid-crtc) [200.775178] Starting subtest: lease-invalid-crtc [200.777551] Starting dynamic subtest: pipe-A-eDP-1 [200.779909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [200.786776] Starting dynamic subtest: pipe-B-eDP-1 [200.788876] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [200.795716] Starting dynamic subtest: pipe-C-eDP-1 [200.797594] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [200.804334] Starting dynamic subtest: pipe-D-eDP-1 [200.806524] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [200.808785] Subtest lease-invalid-crtc: SUCCESS (0.003s) [200.842274] [053/131] (818s left) gem_exec_schedule (preempt-contexts) [200.903463] Starting subtest: preempt-contexts [200.905707] Starting dynamic subtest: rcs0 [200.948293] Dynamic subtest rcs0: SUCCESS (0.050s) [200.957497] Starting dynamic subtest: bcs0 [200.994647] Dynamic subtest bcs0: SUCCESS (0.045s) [201.001675] Starting dynamic subtest: vcs0 [201.038791] Dynamic subtest vcs0: SUCCESS (0.044s) [201.047375] Starting dynamic subtest: vcs1 [201.083186] Dynamic subtest vcs1: SUCCESS (0.043s) [201.091071] Starting dynamic subtest: vecs0 [201.122535] Dynamic subtest vecs0: SUCCESS (0.040s) [201.135086] Starting dynamic subtest: ccs0 [201.160542] Dynamic subtest ccs0: SUCCESS (0.038s) [201.162859] Subtest preempt-contexts: SUCCESS (0.262s) [203.040035] [054/131] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [203.148222] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [203.152472] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [203.235169] [055/131] (816s left) api_intel_allocator (reopen-fork) [203.289020] Starting subtest: reopen-fork [206.846781] Subtest reopen-fork: SUCCESS (3.556s) [206.915799] [056/131] (812s left) kms_flip (2x-flip-vs-modeset) [207.018099] Starting subtest: 2x-flip-vs-modeset [207.028744] Subtest 2x-flip-vs-modeset: SKIP (0.010s) [207.101793] [057/131] (812s left) kms_force_connector_basic (force-edid) [207.176485] Starting subtest: force-edid [207.511693] Subtest force-edid: SUCCESS (0.335s) [207.653909] [058/131] (812s left) kms_getfb (getfb2-handle-protection) [207.702332] Starting subtest: getfb2-handle-protection [207.723312] Subtest getfb2-handle-protection: SUCCESS (0.021s) [207.837813] [059/131] (811s left) i915_suspend (fence-restore-tiled2untiled) [207.893113] Starting subtest: fence-restore-tiled2untiled [207.896352] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [207.989652] [060/131] (811s left) gem_mmap_offset (oob-read) [208.041725] Starting subtest: oob-read [208.043305] Subtest oob-read: SUCCESS (0.000s) [208.135573] [061/131] (811s left) i915_pm_rpm (debugfs-forcewake-user) [210.068629] Starting subtest: debugfs-forcewake-user [221.465283] Subtest debugfs-forcewake-user: SUCCESS (11.399s) [221.810712] [062/131] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [221.927681] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [221.932305] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [222.032349] [063/131] (797s left) kms_atomic_transition (modeset-transition) [222.125724] Starting subtest: modeset-transition [222.128436] Starting dynamic subtest: 1x-outputs [232.685680] Dynamic subtest 1x-outputs: SUCCESS (10.559s) [232.957282] Subtest modeset-transition: SUCCESS (10.831s) [233.780494] [064/131] (786s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt) [233.887753] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt [238.630268] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.745s) [238.763302] [065/131] (781s left) sw_sync (sync_multi_consumer_producer) [238.797619] Starting subtest: sync_multi_consumer_producer [239.111088] Subtest sync_multi_consumer_producer: SUCCESS (0.313s) [239.163491] [066/131] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [239.275654] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [239.280263] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [239.393271] [067/131] (780s left) kms_feature_discovery (display-1x) [239.501228] Starting subtest: display-1x [239.503092] Subtest display-1x: SUCCESS (0.000s) [239.565938] [068/131] (780s left) gem_wait (wait) [239.630062] Starting subtest: wait [239.632314] Starting dynamic subtest: all-engines [240.937785] Dynamic subtest all-engines: SUCCESS (1.306s) [240.946759] Starting dynamic subtest: rcs0 [241.982661] Dynamic subtest rcs0: SUCCESS (1.044s) [241.993169] Starting dynamic subtest: bcs0 [243.028824] Dynamic subtest bcs0: SUCCESS (1.045s) [243.039231] Starting dynamic subtest: vcs0 [244.073364] Dynamic subtest vcs0: SUCCESS (1.044s) [244.082616] Starting dynamic subtest: vcs1 [245.118332] Dynamic subtest vcs1: SUCCESS (1.044s) [245.128097] Starting dynamic subtest: vecs0 [246.165353] Dynamic subtest vecs0: SUCCESS (1.045s) [246.175663] Starting dynamic subtest: ccs0 [247.212480] Dynamic subtest ccs0: SUCCESS (1.046s) [247.215053] Subtest wait: SUCCESS (7.583s) [247.404943] [069/131] (772s left) gem_ctx_param (basic-default) [247.459657] Starting subtest: basic-default [247.461925] Subtest basic-default: SUCCESS (0.000s) [247.529096] [070/131] (772s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [247.585957] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [247.636121] [071/131] (772s left) i915_query (engine-info) [247.695804] Starting subtest: engine-info [247.698616] Subtest engine-info: SUCCESS (0.004s) [247.838164] [072/131] (772s left) gem_ctx_exec (basic-nohangcheck) [247.898025] Starting subtest: basic-nohangcheck [248.234359] Subtest basic-nohangcheck: SUCCESS (0.337s) [248.366174] [073/131] (771s left) perf (non-zero-reason) [248.471494] Starting subtest: non-zero-reason [248.473838] Starting dynamic subtest: 0-rcs0 [253.813572] Dynamic subtest 0-rcs0: SUCCESS (5.341s) [253.823526] Starting dynamic subtest: 1-vcs1 [257.717455] Dynamic subtest 1-vcs1: SUCCESS (3.903s) [257.720346] Subtest non-zero-reason: SUCCESS (9.245s) [257.759344] [074/131] (762s left) kms_psr (fbc-psr-sprite-plane-move) [257.870265] Starting subtest: fbc-psr-sprite-plane-move [257.872667] Starting dynamic subtest: eDP-1 [257.876863] Dynamic subtest eDP-1: SKIP (0.000s) [257.881218] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [257.941373] [075/131] (762s left) gem_ppgtt (blt-vs-render-ctxn) [258.000838] Starting subtest: blt-vs-render-ctxN [291.126597] Subtest blt-vs-render-ctxN: SUCCESS (33.124s) [291.265332] [076/131] (729s left) gem_exec_parallel (basic) [291.354065] Starting subtest: basic [291.356753] Starting dynamic subtest: rcs0 [292.908920] Dynamic subtest rcs0: SUCCESS (1.555s) [292.916793] Starting dynamic subtest: bcs0 [294.395374] Dynamic subtest bcs0: SUCCESS (1.485s) [294.405113] Starting dynamic subtest: vcs0 [295.945040] Dynamic subtest vcs0: SUCCESS (1.548s) [295.953168] Starting dynamic subtest: vcs1 [297.898789] Dynamic subtest vcs1: SUCCESS (1.953s) [297.910034] Starting dynamic subtest: vecs0 [299.946087] Dynamic subtest vecs0: SUCCESS (2.046s) [299.956737] Starting dynamic subtest: ccs0 [301.444614] Dynamic subtest ccs0: SUCCESS (1.498s) [301.446922] Subtest basic: SUCCESS (10.091s) [301.628077] [077/131] (718s left) kms_sequence (get-forked) [301.727764] Starting subtest: get-forked [301.730165] Starting dynamic subtest: pipe-A-eDP-1 [303.664926] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [303.673945] Starting dynamic subtest: pipe-B-eDP-1 [306.213570] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.549s) [306.222079] Starting dynamic subtest: pipe-C-eDP-1 [308.779063] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.564s) [308.787406] Starting dynamic subtest: pipe-D-eDP-1 [311.304453] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s) [311.306882] Subtest get-forked: SUCCESS (9.575s) [312.170586] [078/131] (708s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [312.226423] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [312.228794] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [312.327275] [079/131] (708s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [312.427305] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [316.891539] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.467s) [317.034634] [080/131] (703s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [317.131617] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [322.692410] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.564s) [322.802029] [081/131] (697s left) syncobj_eventfd (timeline-wait-before-signal) [322.871612] Starting subtest: timeline-wait-before-signal [322.901335] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [322.968931] [082/131] (697s left) kms_cursor_crc (cursor-suspend) [323.079760] Starting subtest: cursor-suspend [323.082123] Starting dynamic subtest: pipe-A-eDP-1 [356.154934] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.177s) [356.164346] Starting dynamic subtest: pipe-D-eDP-1 [389.103165] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.610s) [389.106880] Subtest cursor-suspend: SUCCESS (6.790s) [389.975373] [083/131] (689s left) gem_tiled_wb [390.078523] [084/131] (689s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [390.127972] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [390.232512] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s) [390.303885] [085/131] (689s left) gem_ctx_param (vm) [390.360010] Starting subtest: vm [390.402721] Subtest vm: SUCCESS (0.043s) [390.528070] [086/131] (689s left) gem_ctx_persistence (legacy-engines-mixed-process) [390.586196] Starting subtest: legacy-engines-mixed-process [390.588533] Starting dynamic subtest: render [392.109541] Dynamic subtest render: SUCCESS (1.517s) [392.118825] Starting dynamic subtest: bsd1 [394.156158] Dynamic subtest bsd1: SUCCESS (2.041s) [394.166489] Starting dynamic subtest: bsd2 [396.162266] Dynamic subtest bsd2: SUCCESS (2.004s) [396.172177] Starting dynamic subtest: blt [398.153324] Dynamic subtest blt: SUCCESS (1.987s) [398.163586] Starting dynamic subtest: vebox [400.141569] Dynamic subtest vebox: SUCCESS (1.981s) [400.143983] Subtest legacy-engines-mixed-process: SUCCESS (9.537s) [400.215317] [087/131] (679s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [400.322178] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [400.326373] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [400.435144] [088/131] (679s left) kms_addfb_basic (unused-offsets) [400.497748] Starting subtest: unused-offsets [400.500006] Subtest unused-offsets: SUCCESS (0.000s) [400.623411] [089/131] (679s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [400.723210] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [400.725149] Starting dynamic subtest: pipe-A-eDP-1 [401.960017] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.237s) [401.969304] Starting dynamic subtest: pipe-B-eDP-1 [404.293043] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.330s) [404.302264] Starting dynamic subtest: pipe-C-eDP-1 [406.606065] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.311s) [406.615793] Starting dynamic subtest: pipe-D-eDP-1 [408.905336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.296s) [408.907627] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.178s) [410.098023] [090/131] (669s left) debugfs_test (read_all_entries_display_off) [410.211293] Starting subtest: read_all_entries_display_off [411.246936] Subtest read_all_entries_display_off: SUCCESS (1.033s) [411.545807] [091/131] (668s left) kms_plane (plane-panning-top-left) [411.652394] Starting subtest: plane-panning-top-left [411.654793] Starting dynamic subtest: pipe-A [413.342736] Dynamic subtest pipe-A: SUCCESS (1.687s) [413.351302] Starting dynamic subtest: pipe-B [415.717508] Dynamic subtest pipe-B: SUCCESS (2.373s) [415.719951] Subtest plane-panning-top-left: SUCCESS (4.063s) [416.500630] [092/131] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [416.617638] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [416.621782] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [416.725991] [093/131] (663s left) gem_exec_reloc (basic-cpu-gtt) [416.788794] Subtest basic-cpu-gtt: SKIP (0.000s) [416.851005] [094/131] (663s left) kms_prop_blob (blob-prop-validate) [416.922881] Starting subtest: blob-prop-validate [416.925615] Subtest blob-prop-validate: SUCCESS (0.000s) [417.034622] [095/131] (663s left) gem_exec_capture (capture-invisible) [417.105907] Starting subtest: capture-invisible [417.108393] Starting dynamic subtest: smem0 [417.113648] Dynamic subtest smem0: SKIP (0.000s) [417.118355] Subtest capture-invisible: SKIP (0.001s) [417.221324] [096/131] (663s left) sw_sync (alloc_fence) [417.255281] Starting subtest: alloc_fence [417.257673] Subtest alloc_fence: SUCCESS (0.000s) [417.307379] [097/131] (663s left) gem_exec_fence (syncobj-import) [417.761999] Starting subtest: syncobj-import [417.767793] Subtest syncobj-import: SUCCESS (0.006s) [419.234489] [098/131] (661s left) gem_userptr_blits (sync-overlap) [419.306649] Starting subtest: sync-overlap [419.308992] Subtest sync-overlap: SUCCESS (0.000s) [419.421611] [099/131] (660s left) kms_async_flips (alternate-sync-async-flip) [419.531581] Starting subtest: alternate-sync-async-flip [419.911377] Starting dynamic subtest: pipe-A-eDP-1 [422.661661] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.755s) [423.028951] Starting dynamic subtest: pipe-B-eDP-1 [425.759114] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.743s) [426.135910] Starting dynamic subtest: pipe-C-eDP-1 [428.955166] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.832s) [429.320867] Starting dynamic subtest: pipe-D-eDP-1 [432.055611] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.744s) [432.057952] Subtest alternate-sync-async-flip: SUCCESS (12.541s) [433.189035] [100/131] (647s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [433.297372] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [433.299675] Starting dynamic subtest: pipe-A-eDP-1 [433.321907] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [433.330840] Starting dynamic subtest: pipe-B-eDP-1 [433.352340] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [433.360711] Starting dynamic subtest: pipe-C-eDP-1 [433.383130] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [433.391323] Starting dynamic subtest: pipe-D-eDP-1 [433.413288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [433.417674] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.006s) [435.484140] [101/131] (644s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [435.537387] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [435.641717] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s) [435.712335] [102/131] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [435.821361] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [435.825714] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [435.922371] [103/131] (644s left) fbdev (read) [435.967811] Starting subtest: read [436.493492] Subtest read: SUCCESS (0.523s) [436.549961] [104/131] (644s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [436.657868] Starting subtest: fbc-rgb565-draw-mmap-gtt [436.661841] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [436.764036] [105/131] (643s left) kms_cursor_edge_walk (256x256-right-edge) [436.858153] Starting subtest: 256x256-right-edge [436.860478] Starting dynamic subtest: pipe-A-eDP-1 [440.323795] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s) [440.333011] Starting dynamic subtest: pipe-D-eDP-1 [443.487762] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.164s) [443.490156] Subtest 256x256-right-edge: SUCCESS (6.631s) [444.278331] [106/131] (636s left) kms_vrr (flip-basic) [444.386916] Starting subtest: flip-basic [444.393692] Subtest flip-basic: SKIP (0.000s) [444.453907] [107/131] (636s left) kms_addfb_basic (unused-modifier) [444.505355] Starting subtest: unused-modifier [444.507201] Subtest unused-modifier: SUCCESS (0.000s) [444.655628] [108/131] (636s left) gem_ppgtt (flink-and-close-vma-leak) [444.721446] Starting subtest: flink-and-close-vma-leak [444.763818] Subtest flink-and-close-vma-leak: SUCCESS (0.042s) [444.886843] [109/131] (635s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [444.983353] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [444.985721] Starting dynamic subtest: pipe-A-eDP-1 [445.044338] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [445.054575] Starting dynamic subtest: pipe-B-eDP-1 [445.112678] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [445.122873] Starting dynamic subtest: pipe-C-eDP-1 [445.179921] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [445.189863] Starting dynamic subtest: pipe-D-eDP-1 [445.242366] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [445.245788] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s) [447.180819] [110/131] (633s left) gem_exec_whisper (basic-forked) [447.248355] Starting subtest: basic-forked [454.875154] Subtest basic-forked: SUCCESS (7.625s) [455.061765] [111/131] (625s left) gem_pread (exhaustion) [455.125198] Subtest exhaustion: SKIP (0.000s) [455.179618] [112/131] (625s left) gem_softpin (allocator-nopin-reserve) [455.241801] Starting subtest: allocator-nopin-reserve [455.336750] Subtest allocator-nopin-reserve: SUCCESS (0.095s) [455.484644] [113/131] (625s left) perf (oa-formats) [455.580434] Starting subtest: oa-formats [455.582755] Starting dynamic subtest: 0-rcs0 [455.598344] Dynamic subtest 0-rcs0: SUCCESS (0.018s) [455.608293] Starting dynamic subtest: 1-vcs1 [455.633789] Dynamic subtest 1-vcs1: SUCCESS (0.035s) [455.636174] Subtest oa-formats: SUCCESS (0.054s) [455.681362] [114/131] (625s left) kms_flip (2x-plain-flip-interruptible) [455.781797] Starting subtest: 2x-plain-flip-interruptible [455.793579] Subtest 2x-plain-flip-interruptible: SKIP (0.010s) [455.914400] [115/131] (625s left) kms_getfb (getfb-handle-valid) [455.975596] Starting subtest: getfb-handle-valid [455.978095] Subtest getfb-handle-valid: SUCCESS (0.000s) [456.093245] [116/131] (624s left) kms_flip (nonblocking-read) [456.196599] Starting subtest: nonblocking-read [456.198236] Subtest nonblocking-read: SUCCESS (0.000s) [456.316091] [117/131] (624s left) kms_vblank (ts-continuation-idle) [456.407817] Starting subtest: ts-continuation-idle [456.409800] Starting dynamic subtest: pipe-A-eDP-1 [456.819267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s) [456.834040] Starting dynamic subtest: pipe-D-eDP-1 [457.942840] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s) [457.945202] Subtest ts-continuation-idle: SUCCESS (1.533s) [458.777869] [118/131] (622s left) kms_cursor_crc (cursor-onscreen-128x42) [458.985546] Starting subtest: cursor-onscreen-128x42 [459.024211] Subtest cursor-onscreen-128x42: SKIP (0.033s) [459.243002] [119/131] (621s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [459.375318] Starting subtest: cursorB-vs-flipB-atomic-transitions [459.379627] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s) [459.471067] [120/131] (621s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [459.569189] Starting subtest: primary-yf-tiled-reflect-x-180 [459.631181] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [459.729736] [121/131] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [459.840070] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [479.654407] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (19.812s) [479.811233] [122/131] (601s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [480.209767] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [481.059745] [123/131] (600s left) dmabuf_sync_file (export-basic) [481.104132] Starting subtest: export-basic [481.106401] Subtest export-basic: SUCCESS (0.001s) [481.157875] [124/131] (600s left) kms_big_fb (y-tiled-16bpp-rotate-90) [481.258223] Starting subtest: y-tiled-16bpp-rotate-90 [481.262749] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [481.362540] [125/131] (599s left) kms_flip (absolute-wf_vblank-interruptible) [481.463231] Starting subtest: absolute-wf_vblank-interruptible [481.465556] Starting dynamic subtest: A-eDP1 [490.208869] Dynamic subtest A-eDP1: SUCCESS (8.744s) [490.228852] Starting dynamic subtest: B-eDP1 [498.909566] Dynamic subtest B-eDP1: SUCCESS (8.701s) [498.919774] Starting dynamic subtest: C-eDP1 [507.596738] Dynamic subtest C-eDP1: SUCCESS (8.685s) [507.606165] Starting dynamic subtest: D-eDP1 [516.294269] Dynamic subtest D-eDP1: SUCCESS (8.696s) [516.299776] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.837s) [517.474487] [126/131] (563s left) kms_flip (plain-flip-ts-check-interruptible) [517.582999] Starting subtest: plain-flip-ts-check-interruptible [517.585305] Starting dynamic subtest: A-eDP1 [526.439290] Dynamic subtest A-eDP1: SUCCESS (8.854s) [526.448540] Starting dynamic subtest: B-eDP1 [535.338143] Dynamic subtest B-eDP1: SUCCESS (8.897s) [535.348336] Starting dynamic subtest: C-eDP1 [544.228361] Dynamic subtest C-eDP1: SUCCESS (8.888s) [544.239392] Starting dynamic subtest: D-eDP1 [553.027905] Dynamic subtest D-eDP1: SUCCESS (8.798s) [553.033180] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.446s) [554.268367] [127/131] (527s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs) [554.367235] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs [554.371994] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s) [555.468470] [128/131] (525s left) syncobj_timeline (wait-any-complex) [555.519189] Starting subtest: wait-any-complex [555.579355] Subtest wait-any-complex: SUCCESS (0.061s) [555.653062] [129/131] (525s left) kms_big_fb (linear-64bpp-rotate-90) [555.766216] Starting subtest: linear-64bpp-rotate-90 [555.785572] Subtest linear-64bpp-rotate-90: SKIP (0.019s) [555.916266] [130/131] (525s left) kms_content_protection (dp-mst-type-0) [556.095617] Starting subtest: dp-mst-type-0 [556.100394] Subtest dp-mst-type-0: SKIP (0.000s) [556.240513] [131/131] (525s left) vgem_basic (bad-pad) [556.282178] Starting subtest: bad-pad [556.284181] Subtest bad-pad: SUCCESS (0.000s) [556.332937] Closing watchdogs Done.