[58.458180] Initializing watchdogs [58.458243] /dev/watchdog0 [58.471323] [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] [58.475325] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.477429] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.480931] [001/130] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [58.648965] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [58.651396] Starting dynamic subtest: pipe-A-eDP-1 [60.800526] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.148s) [60.807573] Starting dynamic subtest: pipe-B-eDP-1 [62.818898] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.014s) [62.826349] Starting dynamic subtest: pipe-C-eDP-1 [64.816841] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.995s) [64.823809] Starting dynamic subtest: pipe-D-eDP-1 [66.854822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.034s) [66.857206] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.194s) [68.089649] [002/130] (950s left) kms_color (gamma) [68.179912] Starting subtest: gamma [68.182277] Starting dynamic subtest: pipe-A-eDP-1 [68.910563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s) [68.918414] Starting dynamic subtest: pipe-B-eDP-1 [70.268442] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s) [70.276812] Starting dynamic subtest: pipe-C-eDP-1 [71.576714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.308s) [71.583904] Starting dynamic subtest: pipe-D-eDP-1 [72.898426] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s) [72.900613] Subtest gamma: SUCCESS (4.713s) [73.706867] [003/130] (945s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [73.820114] Starting subtest: yf-tiled-64bpp-rotate-180 [73.824505] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [73.901858] [004/130] (945s left) kms_pm_dc (dc6-psr) [75.004825] Starting subtest: dc6-psr [82.217232] Subtest dc6-psr: FAIL (6.629s) [82.246725] [005/130] (936s left) kms_big_fb (4-tiled-32bpp-rotate-270) [82.353266] Starting subtest: 4-tiled-32bpp-rotate-270 [82.373771] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s) [82.510074] [006/130] (936s left) kms_flip (flip-vs-suspend) [82.600358] Starting subtest: flip-vs-suspend [82.602637] Starting dynamic subtest: A-eDP1 [131.841097] Dynamic subtest A-eDP1: SUCCESS (4.478s) [131.848501] Starting dynamic subtest: B-eDP1 [180.852618] Dynamic subtest B-eDP1: SUCCESS (4.295s) [180.860110] Starting dynamic subtest: C-eDP1 [229.861574] Dynamic subtest C-eDP1: SUCCESS (4.272s) [229.874638] Starting dynamic subtest: D-eDP1 [278.858450] Dynamic subtest D-eDP1: SUCCESS (4.284s) [278.860780] Subtest flip-vs-suspend: SUCCESS (17.338s) [279.993019] [007/130] (918s left) kms_rotation_crc (multiplane-rotation) [280.093052] Starting subtest: multiplane-rotation [287.391535] Subtest multiplane-rotation: SUCCESS (7.271s) [287.496952] [008/130] (910s left) perf_pmu (busy-accuracy-2) [287.541710] Starting subtest: busy-accuracy-2 [287.543627] Starting dynamic subtest: rcs0 [290.593744] Dynamic subtest rcs0: SUCCESS (3.042s) [290.603575] Starting dynamic subtest: bcs0 [293.660712] Dynamic subtest bcs0: SUCCESS (3.059s) [293.670691] Starting dynamic subtest: vcs0 [296.709043] Dynamic subtest vcs0: SUCCESS (3.043s) [296.718872] Starting dynamic subtest: vcs1 [299.759122] Dynamic subtest vcs1: SUCCESS (3.045s) [299.767946] Starting dynamic subtest: vecs0 [302.807417] Dynamic subtest vecs0: SUCCESS (3.044s) [302.816133] Starting dynamic subtest: ccs0 [305.874007] Dynamic subtest ccs0: SUCCESS (3.063s) [305.876397] Subtest busy-accuracy-2: SUCCESS (18.308s) [305.997550] [009/130] (892s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [306.127899] Starting subtest: short-flip-before-cursor-atomic-transitions [307.097930] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.968s) [307.956825] [010/130] (890s left) gem_eio (create-ext) [308.159432] Starting subtest: create-ext [308.438179] Subtest create-ext: SUCCESS (0.277s) [308.545237] [011/130] (889s left) gem_exec_fence (basic-wait-all) [308.613424] Starting subtest: basic-wait-all [308.713425] Subtest basic-wait-all: SUCCESS (0.101s) [310.890094] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true [310.893393] [012/130] (887s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [311.006324] Starting subtest: y-tiled-addfb-size-offset-overflow [311.010347] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [311.095185] [013/130] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [311.197867] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [311.202340] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [311.304800] [014/130] (887s left) gem_exec_reloc (basic-range-active) [311.358082] Subtest basic-range-active: SKIP (0.000s) [311.411414] [015/130] (887s left) perf_pmu (module-unload) [311.503255] Starting subtest: module-unload [357.148837] Subtest module-unload: SUCCESS (45.643s) [357.171368] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [357.172146] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [357.175366] [016/130] (841s left) kms_addfb_basic (invalid-set-prop-any) [360.674571] Starting subtest: invalid-set-prop-any [360.676508] Subtest invalid-set-prop-any: SUCCESS (0.000s) [360.796110] [FACT kms_addfb_basic (invalid-set-prop-any)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [360.797733] [FACT kms_addfb_basic (invalid-set-prop-any)] new: kernel.kmod_is_loaded.amdgpu: true [360.797817] [FACT kms_addfb_basic (invalid-set-prop-any)] new: kernel.kmod_is_loaded.i915: true [360.798362] [FACT kms_addfb_basic (invalid-set-prop-any)] new: kernel.kmod_is_loaded.xe: true [360.801507] [017/130] (837s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [360.897950] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [360.900174] Starting dynamic subtest: pipe-A-eDP-1 [360.921930] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [360.930980] Starting dynamic subtest: pipe-B-eDP-1 [360.951845] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [360.958884] Starting dynamic subtest: pipe-C-eDP-1 [360.979819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [360.987249] Starting dynamic subtest: pipe-D-eDP-1 [361.009201] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [361.013255] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [363.050717] [018/130] (835s left) kms_pm_dc (dc5-dpms-negative) [364.164092] Starting subtest: dc5-dpms-negative [364.168556] Subtest dc5-dpms-negative: SKIP (0.000s) [364.229646] [019/130] (834s left) kms_cursor_legacy (flip-vs-cursor-toggle) [364.354262] Starting subtest: flip-vs-cursor-toggle [372.254291] Subtest flip-vs-cursor-toggle: SUCCESS (7.896s) [373.077384] [020/130] (825s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [373.188087] Starting subtest: 4-tiled-addfb-size-offset-overflow [373.190393] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [373.294919] [021/130] (825s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [373.387977] Starting subtest: fbc-psr2-cursor-mmap-gtt [373.390278] Starting dynamic subtest: eDP-1 [373.394741] Dynamic subtest eDP-1: SKIP (0.000s) [373.399142] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s) [373.458785] [022/130] (825s left) gem_spin_batch (legacy-resubmit) [373.533144] Starting subtest: legacy-resubmit [373.535610] Starting dynamic subtest: default [373.540791] Dynamic subtest default: SUCCESS (0.005s) [373.548755] Starting dynamic subtest: render [373.551033] Dynamic subtest render: SUCCESS (0.001s) [373.559448] Starting dynamic subtest: bsd [373.561297] Dynamic subtest bsd: SUCCESS (0.002s) [373.568159] Starting dynamic subtest: bsd1 [373.569965] Dynamic subtest bsd1: SUCCESS (0.002s) [373.577602] Starting dynamic subtest: bsd2 [373.579479] Dynamic subtest bsd2: SUCCESS (0.001s) [373.586208] Starting dynamic subtest: blt [373.588054] Dynamic subtest blt: SUCCESS (0.003s) [373.594627] Starting dynamic subtest: vebox [373.596456] Dynamic subtest vebox: SUCCESS (0.002s) [373.598295] Subtest legacy-resubmit: SUCCESS (0.021s) [373.805547] [023/130] (824s left) kms_cursor_edge_walk (128x128-top-bottom) [373.904637] Starting subtest: 128x128-top-bottom [373.906809] Starting dynamic subtest: pipe-A-eDP-1 [377.332960] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s) [377.341510] Starting dynamic subtest: pipe-D-eDP-1 [380.435275] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.103s) [380.437643] Subtest 128x128-top-bottom: SUCCESS (6.535s) [381.251508] [024/130] (817s left) api_intel_bb (offset-control) [381.316785] Starting subtest: offset-control [381.322071] Subtest offset-control: SUCCESS (0.008s) [381.414821] [025/130] (817s left) gem_ctx_create (basic-files) [381.484586] Starting subtest: basic-files [383.496502] Subtest basic-files: SUCCESS (2.012s) [384.773026] [026/130] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [384.890438] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [389.790554] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (4.904s) [389.934329] [027/130] (808s left) syncobj_timeline (transfer-timeline-point) [389.983294] Starting subtest: transfer-timeline-point [389.985452] Subtest transfer-timeline-point: SUCCESS (0.000s) [390.069457] [028/130] (808s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [390.188336] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [390.192573] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [390.269918] [029/130] (808s left) gem_exec_params (rel-constants-invalid) [390.330807] Starting subtest: rel-constants-invalid [390.332973] Subtest rel-constants-invalid: SUCCESS (0.000s) [390.427744] [030/130] (808s left) kms_getfb (getfb2-handle-protection) [390.483329] Starting subtest: getfb2-handle-protection [390.507177] Subtest getfb2-handle-protection: SUCCESS (0.027s) [390.623267] [031/130] (808s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [390.733373] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [395.234080] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.504s) [395.353229] [032/130] (803s left) kms_addfb_basic (unused-modifier) [395.413567] Starting subtest: unused-modifier [395.415844] Subtest unused-modifier: SUCCESS (0.000s) [395.559766] [033/130] (803s left) drm_fdinfo (context-close-stress) [395.602274] Starting subtest: context-close-stress [406.349248] Subtest context-close-stress: SUCCESS (10.746s) [406.417726] [034/130] (792s left) i915_query (query-topology-unsupported) [406.687880] Starting subtest: query-topology-unsupported [406.692707] Subtest query-topology-unsupported: SKIP (0.000s) [406.801856] [035/130] (792s left) kms_psr (psr2-cursor-mmap-cpu) [406.911752] Starting subtest: psr2-cursor-mmap-cpu [406.913943] Starting dynamic subtest: eDP-1 [408.635273] Dynamic subtest eDP-1: SUCCESS (1.726s) [408.637685] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.727s) [409.410873] [036/130] (789s left) kms_atomic_transition (plane-all-transition-nonblocking) [409.502841] Starting subtest: plane-all-transition-nonblocking [409.505108] Starting dynamic subtest: pipe-A-eDP-1 [412.008542] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [412.295425] Starting dynamic subtest: pipe-B-eDP-1 [415.547134] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.258s) [415.826460] Subtest plane-all-transition-nonblocking: SUCCESS (6.319s) [416.656320] [037/130] (782s left) gem_exec_gttfill (basic) [416.713004] Starting subtest: basic [421.638145] Subtest basic: SUCCESS (4.922s) [421.819780] [038/130] (777s left) kms_vrr (seamless-rr-switch-vrr) [421.974976] Starting subtest: seamless-rr-switch-vrr [421.981792] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [422.041612] [039/130] (777s left) gem_wait (write-wait) [422.115952] Starting subtest: write-wait [422.118276] Starting dynamic subtest: all-engines [423.268428] Dynamic subtest all-engines: SUCCESS (1.152s) [423.280173] Starting dynamic subtest: rcs0 [424.338388] Dynamic subtest rcs0: SUCCESS (1.068s) [424.355463] Starting dynamic subtest: bcs0 [425.399369] Dynamic subtest bcs0: SUCCESS (1.059s) [425.416021] Starting dynamic subtest: vcs0 [426.452971] Dynamic subtest vcs0: SUCCESS (1.052s) [426.466815] Starting dynamic subtest: vcs1 [427.508732] Dynamic subtest vcs1: SUCCESS (1.054s) [427.524220] Starting dynamic subtest: vecs0 [428.563951] Dynamic subtest vecs0: SUCCESS (1.053s) [428.579612] Starting dynamic subtest: ccs0 [429.619961] Dynamic subtest ccs0: SUCCESS (1.054s) [429.622543] Subtest write-wait: SUCCESS (7.504s) [429.818444] [040/130] (769s left) kms_async_flips (test-cursor) [429.930116] Starting subtest: test-cursor [429.934714] Subtest test-cursor: SKIP (0.000s) [431.077335] [041/130] (768s left) kms_big_fb (linear-addfb) [431.188370] Starting subtest: linear-addfb [431.190737] Subtest linear-addfb: SUCCESS (0.000s) [431.300162] [042/130] (768s left) kms_psr (fbc-psr2-suspend) [431.413466] Starting subtest: fbc-psr2-suspend [431.415692] Starting dynamic subtest: eDP-1 [431.419959] Dynamic subtest eDP-1: SKIP (0.000s) [431.424377] Subtest fbc-psr2-suspend: SKIP (0.001s) [431.477823] [043/130] (767s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [436.536749] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [436.539065] Starting dynamic subtest: pipe-A-eDP-1 [437.332974] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s) [437.342410] Starting dynamic subtest: pipe-B-eDP-1 [438.459051] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [438.463784] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.918s) [439.638261] [044/130] (759s left) drm_fdinfo (virtual-busy-hang-all) [439.682781] Starting subtest: virtual-busy-hang-all [439.687285] Subtest virtual-busy-hang-all: SKIP (0.000s) [439.755762] [045/130] (759s left) gem_busy (close-race) [439.823273] Starting subtest: close-race [463.755874] Subtest close-race: SUCCESS (23.925s) [464.115085] [046/130] (735s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [464.245968] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [464.248210] Starting dynamic subtest: pipe-A-default-mode [466.862978] Dynamic subtest pipe-A-default-mode: SUCCESS (2.614s) [466.865422] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.615s) [467.726633] [047/130] (731s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [467.846743] Starting subtest: flip-vs-cursor-busy-crc-legacy [468.624637] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.780s) [469.449767] [048/130] (730s left) syncobj_wait (wait-all-complex) [469.515100] Starting subtest: wait-all-complex [469.730271] Subtest wait-all-complex: SUCCESS (0.213s) [469.804401] [049/130] (729s left) syncobj_eventfd (invalid-bad-pad) [469.854446] Starting subtest: invalid-bad-pad [469.856404] Subtest invalid-bad-pad: SUCCESS (0.000s) [469.954995] [050/130] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [470.061902] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [470.065745] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [470.179284] [051/130] (729s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [470.283262] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [470.285071] Starting dynamic subtest: A-eDP1 [479.198746] Dynamic subtest A-eDP1: SUCCESS (8.911s) [479.209592] Starting dynamic subtest: B-eDP1 [488.122932] Dynamic subtest B-eDP1: SUCCESS (8.921s) [488.132563] Starting dynamic subtest: C-eDP1 [497.034875] Dynamic subtest C-eDP1: SUCCESS (8.907s) [497.044881] Starting dynamic subtest: D-eDP1 [505.964448] Dynamic subtest D-eDP1: SUCCESS (8.927s) [505.966914] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.676s) [507.181715] [052/130] (692s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [507.299327] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [512.435346] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.141s) [512.567785] [053/130] (687s left) kms_psr (psr-sprite-mmap-cpu) [512.677897] Starting subtest: psr-sprite-mmap-cpu [512.680078] Starting dynamic subtest: eDP-1 [514.441265] Dynamic subtest eDP-1: SUCCESS (1.769s) [514.443597] Subtest psr-sprite-mmap-cpu: SUCCESS (1.770s) [515.279537] [054/130] (684s left) gem_exec_whisper (basic-sync-all) [515.340256] Starting subtest: basic-sync-all [522.036770] Subtest basic-sync-all: SUCCESS (6.695s) [522.216431] [055/130] (677s left) kms_flip (2x-flip-vs-expired-vblank) [522.323674] Starting subtest: 2x-flip-vs-expired-vblank [522.335470] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s) [522.412995] [056/130] (677s left) prime_udl [522.497532] [057/130] (677s left) gem_exec_schedule (u-submit-late-slice) [522.574122] Starting subtest: u-submit-late-slice [522.576114] Starting dynamic subtest: rcs0 [522.598430] Dynamic subtest rcs0: SUCCESS (0.031s) [522.610188] Starting dynamic subtest: bcs0 [522.621890] Dynamic subtest bcs0: SUCCESS (0.023s) [522.630949] Starting dynamic subtest: vcs0 [522.647588] Dynamic subtest vcs0: SUCCESS (0.025s) [522.656613] Starting dynamic subtest: vcs1 [522.675492] Dynamic subtest vcs1: SUCCESS (0.028s) [522.685075] Starting dynamic subtest: vecs0 [522.698871] Dynamic subtest vecs0: SUCCESS (0.023s) [522.707983] Starting dynamic subtest: ccs0 [522.725561] Dynamic subtest ccs0: SUCCESS (0.026s) [522.727854] Subtest u-submit-late-slice: SUCCESS (0.158s) [523.889274] [058/130] (676s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [523.986899] Starting subtest: nonblocking-crc-frame-sequence [523.989168] Starting dynamic subtest: pipe-A-eDP-1 [524.734733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s) [524.743564] Starting dynamic subtest: pipe-B-eDP-1 [526.167822] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.433s) [526.177124] Starting dynamic subtest: pipe-C-eDP-1 [527.595551] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.426s) [527.605563] Starting dynamic subtest: pipe-D-eDP-1 [528.988674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s) [528.991068] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.001s) [529.781132] [059/130] (670s left) i915_pm_rpm (reg-read-ioctl) [531.918732] Starting subtest: reg-read-ioctl [534.220177] Subtest reg-read-ioctl: SUCCESS (2.302s) [534.570842] [060/130] (665s left) kms_properties (plane-properties-atomic) [534.669756] Starting subtest: plane-properties-atomic [534.672092] Starting dynamic subtest: pipe-A-eDP-1 [535.239767] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s) [535.251478] Starting dynamic subtest: pipe-B-eDP-1 [536.524325] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.283s) [536.534730] Starting dynamic subtest: pipe-C-eDP-1 [537.737639] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s) [537.746820] Starting dynamic subtest: pipe-D-eDP-1 [538.969889] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [538.972129] Subtest plane-properties-atomic: SUCCESS (4.300s) [539.759876] [061/130] (660s left) gen9_exec_parse (batch-invalid-length) [539.827699] Subtest batch-invalid-length: SKIP (0.000s) [539.896806] [062/130] (660s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [540.001510] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [540.005947] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [540.109251] [063/130] (660s left) i915_suspend (forcewake) [540.167465] Starting subtest: forcewake [571.832253] Subtest forcewake: SUCCESS (2.212s) [571.899231] [064/130] (657s left) gem_exec_flush (basic-uc-prw-default) [571.968773] Starting subtest: basic-uc-prw-default [577.489081] Subtest basic-uc-prw-default: SUCCESS (5.493s) [577.676927] [065/130] (652s left) gem_exec_schedule (fifo) [577.761481] Starting subtest: fifo [577.764622] Starting dynamic subtest: rcs0 [577.876785] Dynamic subtest rcs0: SUCCESS (0.126s) [577.890692] Starting dynamic subtest: vcs0 [577.959367] Dynamic subtest vcs0: SUCCESS (0.081s) [577.974709] Starting dynamic subtest: vcs1 [578.041666] Dynamic subtest vcs1: SUCCESS (0.082s) [578.057194] Starting dynamic subtest: vecs0 [578.127702] Dynamic subtest vecs0: SUCCESS (0.085s) [578.141659] Starting dynamic subtest: ccs0 [578.219495] Dynamic subtest ccs0: SUCCESS (0.092s) [578.222229] Subtest fifo: SUCCESS (0.468s) [579.334594] [066/130] (650s left) kms_cursor_crc (cursor-rapid-movement-128x128) [579.526511] Starting subtest: cursor-rapid-movement-128x128 [579.529371] Starting dynamic subtest: pipe-A-eDP-1 [580.096156] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s) [580.120587] Starting dynamic subtest: pipe-D-eDP-1 [581.296695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.182s) [581.299889] Subtest cursor-rapid-movement-128x128: SUCCESS (1.765s) [582.139688] [067/130] (647s left) gem_ctx_exec (basic-nohangcheck) [582.198195] Starting subtest: basic-nohangcheck [582.441765] Subtest basic-nohangcheck: SUCCESS (0.245s) [582.560912] [068/130] (647s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [582.675799] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [582.680799] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [582.781441] [069/130] (647s left) gem_ctx_persistence (heartbeat-stop) [582.850100] Starting subtest: heartbeat-stop [582.855650] Subtest heartbeat-stop: SKIP (0.000s) [582.937828] [070/130] (646s left) syncobj_timeline (reset-multiple-signaled) [582.984541] Starting subtest: reset-multiple-signaled [582.987134] Subtest reset-multiple-signaled: SUCCESS (0.000s) [583.088417] [071/130] (646s left) syncobj_wait (invalid-reset-illegal-handle) [583.146704] Starting subtest: invalid-reset-illegal-handle [583.149623] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [583.258085] [072/130] (646s left) gem_exec_schedule (preempt-queue) [583.342554] Subtest preempt-queue: SKIP (0.000s) [583.624155] [073/130] (646s left) kms_cursor_crc (cursor-alpha-opaque) [583.724646] Starting subtest: cursor-alpha-opaque [583.727634] Starting dynamic subtest: pipe-A-eDP-1 [584.380155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.651s) [584.396708] Starting dynamic subtest: pipe-D-eDP-1 [585.634265] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s) [585.636924] Subtest cursor-alpha-opaque: SUCCESS (1.903s) [586.497877] [074/130] (643s left) prime_mmap_coherency (ioctl-errors) [586.560941] Starting subtest: ioctl-errors [607.585470] Subtest ioctl-errors: SUCCESS (21.011s) [607.812182] [075/130] (622s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [607.894416] Starting subtest: multi-wait-all-for-submit-available-submitted [607.896546] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [608.001739] [076/130] (622s left) kms_prop_blob (blob-prop-core) [608.062608] Starting subtest: blob-prop-core [608.065390] Subtest blob-prop-core: SUCCESS (0.000s) [608.156193] [077/130] (622s left) kms_rmfb (close-fd) [608.258768] Starting subtest: close-fd [608.261249] Starting dynamic subtest: pipe-A-eDP-1 [608.382090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.120s) [608.392342] Starting dynamic subtest: pipe-B-eDP-1 [609.565792] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s) [609.576473] Starting dynamic subtest: pipe-C-eDP-1 [610.783771] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s) [610.793969] Starting dynamic subtest: pipe-D-eDP-1 [611.912597] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s) [611.915158] Subtest close-fd: SUCCESS (3.652s) [613.101544] [078/130] (617s left) kms_getfb (getfb-repeated-different-handles) [613.215499] Starting subtest: getfb-repeated-different-handles [613.218045] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [613.321347] [079/130] (616s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt) [613.421619] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt [613.426473] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [613.532117] [080/130] (616s left) gem_exec_suspend (basic-s3-devices) [613.600806] Starting subtest: basic-S3-devices [613.603417] Starting dynamic subtest: smem [624.216418] Dynamic subtest smem: SUCCESS (10.612s) [624.219607] Subtest basic-S3-devices: SUCCESS (10.613s) [624.396629] [081/130] (605s left) gem_ccs (ctrl-surf-copy-new-ctx) [624.459280] Starting subtest: ctrl-surf-copy-new-ctx [624.464792] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [624.560168] [082/130] (605s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [624.634620] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [624.639519] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [624.817820] [083/130] (605s left) kms_plane_scaling (invalid-parameters) [624.929369] Starting subtest: invalid-parameters [624.931799] Starting dynamic subtest: less-than-1-height-src [624.937785] Dynamic subtest less-than-1-height-src: SUCCESS (0.010s) [624.949615] Starting dynamic subtest: less-than-1-width-src [624.952644] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s) [624.955632] Subtest invalid-parameters: SUCCESS (0.022s) [625.067050] [084/130] (605s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [625.168642] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [625.171651] Starting dynamic subtest: pipe-A-eDP-1 [625.238712] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [625.247707] Starting dynamic subtest: pipe-B-eDP-1 [625.316528] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [625.327469] Starting dynamic subtest: pipe-C-eDP-1 [625.397375] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [625.413822] Starting dynamic subtest: pipe-D-eDP-1 [625.482493] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [625.487622] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s) [627.321304] [085/130] (603s left) gem_lmem_swapping (smem-oom) [627.363422] Subtest smem-oom: SKIP (0.000s) [627.409828] [086/130] (603s left) kms_universal_plane (disable-primary-vs-flip) [627.524392] Starting subtest: disable-primary-vs-flip [627.526782] Starting dynamic subtest: pipe-A-eDP-1 [629.108018] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.584s) [629.118468] Starting dynamic subtest: pipe-B-eDP-1 [631.540781] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.430s) [631.552442] Starting dynamic subtest: pipe-C-eDP-1 [633.691570] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.150s) [633.702283] Starting dynamic subtest: pipe-D-eDP-1 [635.840502] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.145s) [635.843353] Subtest disable-primary-vs-flip: SUCCESS (8.313s) [636.636154] [087/130] (593s left) gem_pxp (reject-modify-context-protection-off-1) [636.766238] Starting subtest: reject-modify-context-protection-off-1 [636.769152] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s) [636.891950] [088/130] (593s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [641.892425] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [641.895324] Starting dynamic subtest: pipe-A-eDP-1 [648.478056] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.582s) [648.488778] Starting dynamic subtest: pipe-B-eDP-1 [655.110659] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.630s) [655.113396] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.216s) [655.972498] [089/130] (574s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [656.034307] Starting subtest: etime-single-wait-all-for-submit-submitted [656.140188] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s) [656.212638] [090/130] (574s left) gem_mmap_gtt (hang-busy) [656.284668] Subtest hang-busy: SKIP (0.000s) [656.348539] [091/130] (574s left) kms_addfb_basic (basic) [656.398940] Starting subtest: basic [656.401691] Subtest basic: SUCCESS (0.000s) [656.542998] [092/130] (574s left) kms_lease (lease-revoke) [656.638593] Starting subtest: lease-revoke [656.641182] Starting dynamic subtest: pipe-A-eDP-1 [656.685092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.046s) [656.697651] Starting dynamic subtest: pipe-B-eDP-1 [656.738592] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.052s) [656.748669] Starting dynamic subtest: pipe-C-eDP-1 [656.782795] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.043s) [656.794179] Starting dynamic subtest: pipe-D-eDP-1 [656.833177] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.046s) [656.835536] Subtest lease-revoke: SUCCESS (0.192s) [656.955737] [093/130] (573s left) perf (invalid-oa-format-id) [657.079406] Starting subtest: invalid-oa-format-id [657.097769] Subtest invalid-oa-format-id: SUCCESS (0.017s) [657.136417] [094/130] (573s left) kms_chamelium_color (ctm-0-50) [657.235074] Subtest ctm-0-50: SKIP (0.000s) [657.276229] [095/130] (573s left) gem_mmap_wc (write) [657.345034] Subtest write: SKIP (0.000s) [657.410857] [096/130] (573s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [657.477080] Starting subtest: etime-multi-wait-for-submit-submitted [657.587567] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s) [657.658795] [097/130] (573s left) kms_chamelium_hpd (dp-hpd-storm) [658.037298] Subtest dp-hpd-storm: SKIP (0.000s) [658.873437] [098/130] (572s left) kms_invalid_mode (zero-clock) [658.973452] Starting subtest: zero-clock [658.975700] Starting dynamic subtest: pipe-A-eDP-1 [659.259618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [659.269641] Starting dynamic subtest: pipe-B-eDP-1 [659.272174] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [659.281711] Starting dynamic subtest: pipe-C-eDP-1 [659.284484] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [659.295476] Starting dynamic subtest: pipe-D-eDP-1 [659.297986] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [659.300474] Subtest zero-clock: SUCCESS (0.289s) [660.126133] [099/130] (570s left) gem_exec_fence (submit67) [660.304179] Starting subtest: submit67 [660.310348] Subtest submit67: SKIP (0.000s) [662.326133] [100/130] (568s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [662.417502] Starting subtest: planes-downscale-factor-0-5-unity-scaling [662.420137] Starting dynamic subtest: pipe-A [662.431351] Dynamic subtest pipe-A: SKIP (0.004s) [662.443571] Starting dynamic subtest: pipe-B [662.454441] Dynamic subtest pipe-B: SKIP (0.015s) [662.464515] Starting dynamic subtest: pipe-C [662.474574] Dynamic subtest pipe-C: SKIP (0.016s) [662.483783] Starting dynamic subtest: pipe-D [662.492923] Dynamic subtest pipe-D: SKIP (0.015s) [662.497702] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.052s) [662.591671] [101/130] (568s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [662.700866] Starting subtest: psr-indfb-scaledprimary [666.328801] Subtest psr-indfb-scaledprimary: SUCCESS (3.629s) [666.479720] [102/130] (564s left) gem_exec_suspend (basic-s4-devices) [666.536334] Starting subtest: basic-S4-devices [666.538893] Starting dynamic subtest: smem [678.232306] Dynamic subtest smem: SUCCESS (11.692s) [678.235103] Subtest basic-S4-devices: SUCCESS (11.694s) [678.391229] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2463 [max: 8192] direct dependencies: 30394 [max: 524288] indirect dependencies: 265463 all direct dependencies: 652949 dependency chains: 48778 [max: 524288] dependency chain hlocks used: 218628 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 427 in-softirq chains: 1059 in-process chains: 47292 stack-trace entries: 373485 [max: 524288] number of stack traces: 16387 number of stack hash chains: 10350 combined max dependencies: 4276019056 hardirq-safe locks: 141 hardirq-unsafe locks: 1399 softirq-safe locks: 284 softirq-unsafe locks: 1291 irq-safe locks: 304 irq-unsafe locks: 1399 hardirq-read-safe locks: 5 hardirq-read-unsafe locks: 494 softirq-read-safe locks: 10 softirq-read-unsafe locks: 489 irq-read-safe locks: 10 irq-read-unsafe locks: 494 uncategorized locks: 403 unused locks: 1 max locking depth: 17 max bfs queue depth: 460 max lock class index: 2462 debug_locks: 0 zapped classes: 585 zapped lock chains: 15637 large chain blocks: 1 [678.403865] Closing watchdogs Done.