[57.070984] Initializing watchdogs [57.071045] /dev/watchdog0 [57.085169] [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.089711] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.091914] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.094227] [001/132] (960s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [57.162932] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [57.165062] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [57.362355] [002/132] (960s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [62.392972] Starting subtest: psr2-overlay-plane-move-continuous-sf [62.394080] Starting dynamic subtest: pipe-A-eDP-1 [69.068915] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.679s) [69.081088] Starting dynamic subtest: pipe-B-eDP-1 [75.714291] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.645s) [75.715199] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.327s) [76.528608] [003/132] (941s left) gem_mmap_gtt (big-copy-odd) [76.583117] Subtest big-copy-odd: SKIP (0.000s) [76.672814] [004/132] (941s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [76.776485] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [76.777404] Starting dynamic subtest: pipe-A [76.792540] Dynamic subtest pipe-A: SKIP (0.015s) [76.798187] Starting dynamic subtest: pipe-B [76.820580] Dynamic subtest pipe-B: SKIP (0.027s) [76.826037] Starting dynamic subtest: pipe-C [76.851856] Dynamic subtest pipe-C: SKIP (0.031s) [76.857214] Starting dynamic subtest: pipe-D [76.880087] Dynamic subtest pipe-D: SKIP (0.028s) [76.881662] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.103s) [77.015609] [005/132] (940s left) syncobj_wait (wait-for-submit-complex) [77.082364] Starting subtest: wait-for-submit-complex [77.143845] Subtest wait-for-submit-complex: SUCCESS (0.062s) [77.231819] [006/132] (940s left) gem_cs_tlb (engines) [77.280438] Starting subtest: engines [77.281379] Starting dynamic subtest: rcs0 [79.436791] Dynamic subtest rcs0: SUCCESS (2.153s) [79.444995] Starting dynamic subtest: bcs0 [81.588211] Dynamic subtest bcs0: SUCCESS (2.152s) [81.596195] Starting dynamic subtest: vcs0 [83.741385] Dynamic subtest vcs0: SUCCESS (2.151s) [83.749091] Starting dynamic subtest: vcs1 [85.893627] Dynamic subtest vcs1: SUCCESS (2.152s) [85.901543] Starting dynamic subtest: vecs0 [88.045958] Dynamic subtest vecs0: SUCCESS (2.151s) [88.054165] Starting dynamic subtest: ccs0 [90.197876] Dynamic subtest ccs0: SUCCESS (2.154s) [90.198699] Subtest engines: SUCCESS (12.915s) [90.350793] [007/132] (927s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [90.469025] Starting subtest: basic-busy-flip-before-cursor-legacy [90.470822] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [90.628173] [008/132] (927s left) perf_pmu (init-busy) [90.658660] Starting subtest: init-busy [90.659685] Starting dynamic subtest: rcs0 [90.660561] Dynamic subtest rcs0: SUCCESS (0.001s) [90.667239] Starting dynamic subtest: bcs0 [90.668104] Dynamic subtest bcs0: SUCCESS (0.000s) [90.673261] Starting dynamic subtest: vcs0 [90.674065] Dynamic subtest vcs0: SUCCESS (0.001s) [90.679139] Starting dynamic subtest: vcs1 [90.679957] Dynamic subtest vcs1: SUCCESS (0.001s) [90.685062] Starting dynamic subtest: vecs0 [90.685874] Dynamic subtest vecs0: SUCCESS (0.001s) [90.691120] Starting dynamic subtest: ccs0 [90.691981] Dynamic subtest ccs0: SUCCESS (0.000s) [90.692863] Subtest init-busy: SUCCESS (0.005s) [90.798557] [009/132] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [90.883422] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [90.885256] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [91.004200] [010/132] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [91.094902] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [91.096634] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [91.215325] [011/132] (926s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [91.303606] Starting subtest: switch-modeset-ultra-joiner-big-joiner [91.305393] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [91.385070] [012/132] (926s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [91.478856] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [95.264564] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.786s) [96.419972] [013/132] (921s left) gem_eio (in-flight-contexts-10ms) [96.643204] Starting subtest: in-flight-contexts-10ms [109.927953] Subtest in-flight-contexts-10ms: SUCCESS (13.286s) [110.118885] [014/132] (907s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [110.204765] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [110.205758] Starting dynamic subtest: pipe-A-eDP-1 [110.982548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s) [110.989383] Starting dynamic subtest: pipe-B-eDP-1 [112.528439] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s) [112.535488] Starting dynamic subtest: pipe-C-eDP-1 [114.022828] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s) [114.029538] Starting dynamic subtest: pipe-D-eDP-1 [115.593692] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.570s) [115.594560] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.386s) [116.759721] [015/132] (901s left) i915_query (engine-info) [116.823420] Starting subtest: engine-info [116.827517] Subtest engine-info: SUCCESS (0.005s) [116.961679] [016/132] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [117.053894] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [117.055658] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [117.170753] [017/132] (900s left) kms_plane_alpha_blend (constant-alpha-max) [117.268241] Starting subtest: constant-alpha-max [117.549443] Starting dynamic subtest: pipe-A-eDP-1 [118.434370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.884s) [118.441259] Starting dynamic subtest: pipe-D-eDP-1 [120.028516] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.593s) [120.029793] Subtest constant-alpha-max: SUCCESS (2.760s) [120.921310] [018/132] (897s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [121.045935] Starting subtest: cursorA-vs-flipA-atomic [132.164600] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.118s) [133.046132] [019/132] (885s left) kms_psr (psr-basic) [133.144505] Starting subtest: psr-basic [133.145552] Starting dynamic subtest: eDP-1 [134.711941] Dynamic subtest eDP-1: SUCCESS (1.568s) [134.712998] Subtest psr-basic: SUCCESS (1.569s) [135.530283] [020/132] (882s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [135.622804] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [135.624693] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [136.754725] [021/132] (881s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [136.846217] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [136.847065] Starting dynamic subtest: pipe-A-eDP-1 [136.855354] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [136.862231] Starting dynamic subtest: pipe-B-eDP-1 [136.870725] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [136.877328] Starting dynamic subtest: pipe-C-eDP-1 [136.885838] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [136.892194] Starting dynamic subtest: pipe-D-eDP-1 [136.900668] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [136.902362] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.006s) [139.027703] [022/132] (879s left) gen9_exec_parse (valid-registers) [139.084227] Subtest valid-registers: SKIP (0.000s) [139.167616] [023/132] (879s left) gem_watchdog (default-physical) [139.230998] Starting subtest: default-physical [141.252576] Subtest default-physical: SUCCESS (2.019s) [141.367339] [024/132] (876s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [141.424442] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [141.425467] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [141.559842] [025/132] (876s left) gem_exercise_blt (fast-copy-emit) [141.626455] Starting subtest: fast-copy-emit [141.627559] Starting dynamic subtest: linear-smem-smem-emit [141.654122] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.027s) [141.662899] Starting dynamic subtest: xmajor-smem-smem-emit [141.675172] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.020s) [141.680970] Starting dynamic subtest: tile4-smem-smem-emit [141.693198] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s) [141.699054] Starting dynamic subtest: tile64-smem-smem-emit [141.711550] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s) [141.712455] Subtest fast-copy-emit: SUCCESS (0.085s) [141.876291] [026/132] (876s left) kms_vblank (query-busy-hang) [141.975837] Starting subtest: query-busy-hang [141.976687] Starting dynamic subtest: pipe-A-eDP-1 [169.737601] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.759s) [169.746521] Starting dynamic subtest: pipe-D-eDP-1 [184.701104] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.960s) [184.702063] Subtest query-busy-hang: SUCCESS (42.724s) [185.597680] [027/132] (832s left) gem_exec_reloc (basic-write-read-noreloc) [185.663354] Subtest basic-write-read-noreloc: SKIP (0.000s) [185.737269] [028/132] (832s left) gem_ctx_sseu (invalid-sseu) [185.798166] Subtest invalid-sseu: SKIP (0.000s) [185.856713] [029/132] (832s left) kms_plane_multiple (tiling-4) [185.936053] Starting subtest: tiling-4 [185.936888] Starting dynamic subtest: pipe-A-eDP-1 [189.753411] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.817s) [189.760497] Starting dynamic subtest: pipe-B-eDP-1 [194.249092] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.494s) [194.255386] Starting dynamic subtest: pipe-C-eDP-1 [198.578366] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.328s) [198.585201] Starting dynamic subtest: pipe-D-eDP-1 [202.898623] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.319s) [202.899575] Subtest tiling-4: SUCCESS (16.962s) [203.732677] [030/132] (814s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [208.806214] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [208.809110] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [209.673655] [031/132] (808s left) i915_hangman (engine-error-state-capture) [209.742453] Starting subtest: engine-error-state-capture [209.743445] Starting dynamic subtest: rcs0 [212.854094] Dynamic subtest rcs0: SUCCESS (3.109s) [212.863474] Starting dynamic subtest: bcs0 [218.869338] Dynamic subtest bcs0: SUCCESS (6.012s) [218.879074] Starting dynamic subtest: vcs0 [224.823375] Dynamic subtest vcs0: SUCCESS (5.952s) [224.832497] Starting dynamic subtest: vcs1 [228.855861] Dynamic subtest vcs1: SUCCESS (4.029s) [228.866053] Starting dynamic subtest: vecs0 [234.806064] Dynamic subtest vecs0: SUCCESS (5.948s) [234.815393] Starting dynamic subtest: ccs0 [239.861940] Dynamic subtest ccs0: SUCCESS (5.053s) [239.863592] Subtest engine-error-state-capture: SUCCESS (30.118s) [239.960634] [032/132] (778s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [240.058983] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [240.059886] Starting dynamic subtest: pipe-A-eDP-1 [240.067835] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [240.073882] Starting dynamic subtest: pipe-B-eDP-1 [240.082046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [240.088329] Starting dynamic subtest: pipe-C-eDP-1 [240.096352] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [240.102221] Starting dynamic subtest: pipe-D-eDP-1 [240.110493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [240.112168] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [242.243840] [033/132] (776s left) gem_exec_params (secure-non-root) [242.305412] Starting subtest: secure-non-root [242.307380] Subtest secure-non-root: SKIP (0.000s) [242.417899] [034/132] (776s left) prime_vgem (coherency-blt) [242.578861] Starting subtest: coherency-blt [243.715730] Subtest coherency-blt: SUCCESS (1.134s) [243.878426] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true [243.880284] [035/132] (774s left) kms_pm_rpm (basic-pci-d3-state) [246.102951] Starting subtest: basic-pci-d3-state [247.589553] Subtest basic-pci-d3-state: SUCCESS (1.489s) [247.699381] [036/132] (770s left) kms_frontbuffer_tracking (basic) [247.796572] Starting subtest: basic [250.989262] Subtest basic: SUCCESS (3.194s) [251.157919] [037/132] (767s left) kms_psr (fbc-psr2-suspend) [251.249365] Starting subtest: fbc-psr2-suspend [251.250297] Starting dynamic subtest: eDP-1 [251.251995] Dynamic subtest eDP-1: SKIP (0.000s) [251.253732] Subtest fbc-psr2-suspend: SKIP (0.001s) [251.342290] [038/132] (767s left) gem_exec_schedule (submit-late-slice) [251.406063] Starting subtest: submit-late-slice [251.407085] Starting dynamic subtest: rcs0 [251.444691] Dynamic subtest rcs0: SUCCESS (0.038s) [251.453756] Starting dynamic subtest: bcs0 [251.480954] Dynamic subtest bcs0: SUCCESS (0.036s) [251.489924] Starting dynamic subtest: vcs0 [251.513843] Dynamic subtest vcs0: SUCCESS (0.032s) [251.520484] Starting dynamic subtest: vcs1 [251.546210] Dynamic subtest vcs1: SUCCESS (0.032s) [251.553377] Starting dynamic subtest: vecs0 [251.579168] Dynamic subtest vecs0: SUCCESS (0.032s) [251.585438] Starting dynamic subtest: ccs0 [251.615423] Dynamic subtest ccs0: SUCCESS (0.035s) [251.616401] Subtest submit-late-slice: SUCCESS (0.210s) [252.979793] [039/132] (765s left) core_getversion (basic) [253.013013] Starting subtest: basic [253.014904] Subtest basic: SUCCESS (0.000s) [253.105367] [040/132] (765s left) syncobj_wait (wait-all-complex) [253.164404] Starting subtest: wait-all-complex [253.378745] Subtest wait-all-complex: SUCCESS (0.212s) [253.467432] [041/132] (765s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [253.555077] Starting subtest: primary-4-tiled-reflect-x-180 [260.567269] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.013s) [261.826057] [042/132] (757s left) drm_read (empty-nonblock) [261.982526] Starting subtest: empty-nonblock [261.983438] Subtest empty-nonblock: SUCCESS (0.000s) [262.153756] [043/132] (756s left) gem_exec_fence (expired-history) [262.595572] Starting subtest: expired-history [269.654031] Subtest expired-history: SUCCESS (7.057s) [270.287599] [044/132] (748s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [270.393130] Starting subtest: fbc-dirtyfb-ioctl [270.394055] Starting dynamic subtest: A-eDP-1 [272.980670] Dynamic subtest A-eDP-1: SUCCESS (2.587s) [272.981574] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.588s) [273.797596] [045/132] (745s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [273.887252] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [273.888969] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [273.995574] [046/132] (745s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [274.093622] Starting subtest: yf-tiled-64bpp-rotate-0 [274.095470] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [274.216068] [047/132] (744s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [274.304859] Starting subtest: plane-lut1d-post-ctm3x4 [274.319776] Starting dynamic subtest: pipe-A-eDP-1 [274.771706] Dynamic subtest pipe-A-eDP-1: FAIL (0.303s) [275.661920] Starting dynamic subtest: pipe-B-eDP-1 [276.117825] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s) [276.989875] Starting dynamic subtest: pipe-C-eDP-1 [277.490684] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s) [278.317854] Starting dynamic subtest: pipe-D-eDP-1 [278.779599] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s) [278.838597] Subtest plane-lut1d-post-ctm3x4: FAIL (4.534s) [279.708537] [048/132] (739s left) kms_cursor_crc (cursor-offscreen-256x85) [279.952132] Starting subtest: cursor-offscreen-256x85 [279.990494] Subtest cursor-offscreen-256x85: SKIP (0.037s) [280.185116] [049/132] (738s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [280.573065] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [281.391432] [050/132] (737s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [281.499353] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [285.129903] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.630s) [286.324608] [051/132] (732s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [286.382947] Starting subtest: invalid-smem-bo-on-discrete [286.385616] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [286.534809] [052/132] (732s left) gem_eio (hibernate) [286.765143] Starting subtest: hibernate [301.313953] Subtest hibernate: SUCCESS (14.550s) [309.507271] [053/132] (717s left) syncobj_wait (invalid-multi-wait-unsubmitted) [309.575289] Starting subtest: invalid-multi-wait-unsubmitted [309.576166] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [309.701787] [054/132] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [309.793065] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [309.794826] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [309.900783] [055/132] (717s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [309.997259] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [309.999836] Starting dynamic subtest: A-eDP1 [318.884067] Dynamic subtest A-eDP1: SUCCESS (8.883s) [318.895093] Starting dynamic subtest: B-eDP1 [327.811736] Dynamic subtest B-eDP1: SUCCESS (8.924s) [327.822525] Starting dynamic subtest: C-eDP1 [336.731212] Dynamic subtest C-eDP1: SUCCESS (8.917s) [336.740564] Starting dynamic subtest: D-eDP1 [345.581338] Dynamic subtest D-eDP1: SUCCESS (8.849s) [345.584222] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.584s) [346.823900] [056/132] (680s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [346.949922] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [356.040560] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.090s) [356.857130] [057/132] (670s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [356.961518] Starting subtest: flip-vs-cursor-busy-crc-atomic [357.746345] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.784s) [358.598112] [058/132] (668s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [358.704364] Starting subtest: fbcpsr-modesetfrombusy [364.834313] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.130s) [364.981943] [059/132] (662s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [365.087399] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [365.088929] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [365.198571] [060/132] (662s left) i915_pm_rpm (system-suspend-devices) [367.134103] Starting subtest: system-suspend-devices [378.499688] Subtest system-suspend-devices: SUCCESS (11.370s) [385.909032] [061/132] (648s left) kms_lease (master-vs-lease) [386.013183] Starting subtest: master-vs-lease [386.014135] Subtest master-vs-lease: SUCCESS (0.002s) [386.135612] [062/132] (648s left) syncobj_wait (wait-delayed-signal) [386.185091] Starting subtest: wait-delayed-signal [386.289542] Subtest wait-delayed-signal: SUCCESS (0.102s) [386.386479] [063/132] (648s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [386.486796] Starting subtest: fbc-rgb565-draw-pwrite [391.036864] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.550s) [392.196236] [064/132] (642s left) kms_pm_rpm (pm-caching) [394.018471] Starting subtest: pm-caching [394.020791] Subtest pm-caching: SKIP (0.000s) [394.429402] [065/132] (640s left) api_intel_bb (render-ccs) [394.488722] Starting subtest: render-ccs [394.844924] Subtest render-ccs: SUCCESS (0.355s) [395.015842] [066/132] (639s left) kms_content_protection (legacy-hdcp14) [395.148869] Starting subtest: legacy-hdcp14 [395.150858] Subtest legacy-hdcp14: SKIP (0.000s) [395.310979] [067/132] (639s left) gem_exec_flush (basic-batch-kernel-default-cmd) [395.383840] Starting subtest: basic-batch-kernel-default-cmd [395.385522] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [395.586193] [068/132] (639s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [395.645937] Starting subtest: etime-single-wait-for-submit-unsubmitted [395.755507] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s) [395.849155] [069/132] (638s left) gem_lmem_swapping (verify-random) [395.891062] Subtest verify-random: SKIP (0.000s) [395.930801] [070/132] (638s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [396.023798] Starting subtest: primary-yf-tiled-reflect-x-0 [396.083433] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s) [396.210552] [071/132] (638s left) kms_big_fb (x-tiled-32bpp-rotate-0) [396.302343] Starting subtest: x-tiled-32bpp-rotate-0 [397.614892] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.313s) [397.775774] [072/132] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [397.867388] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [397.868925] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [397.984706] [073/132] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [398.076577] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [398.078330] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [398.208017] [074/132] (636s left) kms_psr (fbc-psr-sprite-blt) [398.301198] Starting subtest: fbc-psr-sprite-blt [398.303370] Starting dynamic subtest: eDP-1 [398.305045] Dynamic subtest eDP-1: SKIP (0.000s) [398.306658] Subtest fbc-psr-sprite-blt: SKIP (0.003s) [398.401401] [075/132] (636s left) gen9_exec_parse (allowed-all) [398.454732] Subtest allowed-all: SKIP (0.000s) [398.507842] [076/132] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [398.601029] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [398.602718] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [398.712043] [077/132] (636s left) gem_pxp (verify-pxp-stale-buf-execution) [398.836947] Starting subtest: verify-pxp-stale-buf-execution [399.899153] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s) [400.056856] [078/132] (635s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [400.101993] Starting subtest: invalid-single-wait-all-unsubmitted [400.103047] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [400.233099] [079/132] (634s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [400.294923] Starting subtest: legacy-engines-hostile-preempt [400.296044] Starting dynamic subtest: render [400.398474] Dynamic subtest render: SUCCESS (0.103s) [400.410020] Starting dynamic subtest: bsd1 [401.897768] Dynamic subtest bsd1: SUCCESS (1.494s) [401.907746] Starting dynamic subtest: bsd2 [403.958812] Dynamic subtest bsd2: SUCCESS (2.058s) [403.971176] Starting dynamic subtest: blt [404.046851] Dynamic subtest blt: SUCCESS (0.087s) [404.058218] Starting dynamic subtest: vebox [405.889346] Dynamic subtest vebox: SUCCESS (1.837s) [405.890874] Subtest legacy-engines-hostile-preempt: SUCCESS (5.593s) [406.036614] [080/132] (629s left) i915_query (query-topology-unsupported) [406.093677] Starting subtest: query-topology-unsupported [406.095548] Subtest query-topology-unsupported: SKIP (0.000s) [406.222575] [081/132] (628s left) syncobj_timeline (invalid-wait-bad-flags) [406.271639] Starting subtest: invalid-wait-bad-flags [406.272453] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [406.401832] [082/132] (628s left) kms_addfb_basic (too-wide) [406.506927] Starting subtest: too-wide [406.507752] Subtest too-wide: SUCCESS (0.000s) [406.632695] [083/132] (628s left) gem_mmap_wc (write-prefaulted) [406.694949] Subtest write-prefaulted: SKIP (0.000s) [406.760273] [084/132] (628s left) kms_flip (flip-vs-modeset-vs-hang) [406.835396] Starting subtest: flip-vs-modeset-vs-hang [406.837960] Starting dynamic subtest: A-eDP1 [446.428619] Dynamic subtest A-eDP1: SUCCESS (39.588s) [446.438422] Starting dynamic subtest: D-eDP1 [496.376883] Dynamic subtest D-eDP1: SUCCESS (49.945s) [496.378511] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.539s) [496.803336] [085/132] (538s left) gem_softpin (evict-active) [496.866790] Starting subtest: evict-active [496.873920] Subtest evict-active: SUCCESS (0.007s) [497.026788] [086/132] (538s left) gem_exec_whisper (basic-forked) [497.087376] Starting subtest: basic-forked [504.643285] Subtest basic-forked: SUCCESS (7.555s) [504.845821] [087/132] (530s left) kms_chamelium_frames (vga-frame-dump) [505.236517] Subtest vga-frame-dump: SKIP (0.000s) [506.082857] [088/132] (529s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [506.161759] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [506.162788] Starting dynamic subtest: pipe-A-default-mode [506.448565] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [506.450319] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.287s) [507.264430] [089/132] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [507.352812] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [507.354558] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [507.489053] [090/132] (527s left) gem_exec_schedule (pi-distinct-iova) [507.662435] Starting subtest: pi-distinct-iova [507.663536] Starting dynamic subtest: rcs0 [507.747904] Dynamic subtest rcs0: SUCCESS (0.086s) [507.756343] Starting dynamic subtest: vcs0 [507.805946] Dynamic subtest vcs0: SUCCESS (0.057s) [507.816158] Starting dynamic subtest: vcs1 [507.916822] Dynamic subtest vcs1: SUCCESS (0.108s) [507.928539] Starting dynamic subtest: vecs0 [507.975149] Dynamic subtest vecs0: SUCCESS (0.058s) [507.986388] Starting dynamic subtest: ccs0 [508.034063] Dynamic subtest ccs0: SUCCESS (0.058s) [508.035924] Subtest pi-distinct-iova: SUCCESS (0.373s) [509.015955] [091/132] (526s left) perf_pmu (invalid-open) [509.051274] Starting subtest: invalid-open [509.052240] Subtest invalid-open: SUCCESS (0.000s) [509.185465] [092/132] (526s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [509.280971] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [509.282906] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [509.420524] [093/132] (526s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [509.515603] Starting subtest: psr-rgb101010-draw-blt [516.827243] Subtest psr-rgb101010-draw-blt: SUCCESS (7.313s) [516.985161] [094/132] (518s left) kms_chamelium_edid (dp-edid-change-during-suspend) [517.369067] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [518.162662] [095/132] (517s left) gem_set_tiling_vs_blt (tiled-to-untiled) [518.224486] Subtest tiled-to-untiled: SKIP (0.000s) [518.308079] [096/132] (517s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [518.412834] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [518.414846] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [518.568830] [097/132] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [518.667397] Starting subtest: psr-1p-primscrn-spr-indfb-move [526.069799] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.403s) [526.248904] [098/132] (509s left) kms_getfb (getfb-reject-nv12) [526.342482] Starting subtest: getfb-reject-nv12 [526.343418] Subtest getfb-reject-nv12: SUCCESS (0.001s) [526.483422] [099/132] (509s left) gem_spin_batch (legacy-resubmit-new) [526.545335] Starting subtest: legacy-resubmit-new [526.546435] Starting dynamic subtest: default [526.553383] Dynamic subtest default: SUCCESS (0.007s) [526.563151] Starting dynamic subtest: render [526.563998] Dynamic subtest render: SUCCESS (0.003s) [526.572072] Starting dynamic subtest: bsd [526.572904] Dynamic subtest bsd: SUCCESS (0.004s) [526.580831] Starting dynamic subtest: bsd1 [526.581694] Dynamic subtest bsd1: SUCCESS (0.004s) [526.589322] Starting dynamic subtest: bsd2 [526.590093] Dynamic subtest bsd2: SUCCESS (0.003s) [526.597773] Starting dynamic subtest: blt [526.598591] Dynamic subtest blt: SUCCESS (0.004s) [526.606232] Starting dynamic subtest: vebox [526.606999] Dynamic subtest vebox: SUCCESS (0.003s) [526.607867] Subtest legacy-resubmit-new: SUCCESS (0.033s) [527.954608] [100/132] (507s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [528.057658] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [535.550523] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.493s) [535.708271] [101/132] (500s left) gem_ctx_isolation (preservation) [535.772417] Starting subtest: preservation [535.773320] Starting dynamic subtest: rcs0 [535.920827] Dynamic subtest rcs0: SUCCESS (0.148s) [535.929632] Starting dynamic subtest: bcs0 [536.090556] Dynamic subtest bcs0: SUCCESS (0.169s) [536.100782] Starting dynamic subtest: vcs0 [536.258109] Dynamic subtest vcs0: SUCCESS (0.166s) [536.266344] Starting dynamic subtest: vcs1 [538.030022] Dynamic subtest vcs1: SUCCESS (1.771s) [538.041058] Starting dynamic subtest: vecs0 [540.062544] Dynamic subtest vecs0: SUCCESS (2.032s) [540.074522] Starting dynamic subtest: ccs0 [542.068771] Dynamic subtest ccs0: SUCCESS (2.005s) [542.069997] Subtest preservation: SUCCESS (6.296s) [542.334645] [102/132] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [542.437718] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [542.439411] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [542.563490] [103/132] (493s left) gem_wait (invalid-flags) [542.629950] Starting subtest: invalid-flags [542.630901] Subtest invalid-flags: SUCCESS (0.000s) [542.914155] [104/132] (493s left) kms_dsc (dsc-with-bpc-formats) [542.999287] Starting subtest: dsc-with-bpc-formats [543.041031] Subtest dsc-with-bpc-formats: SKIP (0.003s) [543.089830] [105/132] (492s left) gem_mmap_offset (clear-via-pagefault) [543.139305] Starting subtest: clear-via-pagefault [543.140150] Starting dynamic subtest: smem0 [572.059448] Dynamic subtest smem0: FAIL (28.894s) [572.060359] Subtest clear-via-pagefault: FAIL (28.896s) [572.156440] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [572.176467] [FACT gem_mmap_offset (clear-via-pagefault)] new: kernel.is_tainted.taint_warn: true [572.177348] Closing watchdogs results: parsing output: 0/ for test: gem_render_copy results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: gem_mmap_gtt results: parsing output: 3/ for test: kms_plane_scaling results: parsing output: 4/ for test: syncobj_wait results: parsing output: 5/ for test: gem_cs_tlb results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: perf_pmu results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_joiner results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_eio results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: i915_query results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_plane_alpha_blend results: parsing output: 17/ for test: kms_cursor_legacy results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: gen9_exec_parse results: parsing output: 22/ for test: gem_watchdog results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: gem_exercise_blt results: parsing output: 25/ for test: kms_vblank results: parsing output: 26/ for test: gem_exec_reloc results: parsing output: 27/ for test: gem_ctx_sseu results: parsing output: 28/ for test: kms_plane_multiple results: parsing output: 29/ for test: kms_psr2_sf results: parsing output: 30/ for test: i915_hangman results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: gem_exec_params results: parsing output: 33/ for test: prime_vgem results: parsing output: 34/ for test: kms_pm_rpm results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: gem_exec_schedule results: parsing output: 38/ for test: core_getversion results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: kms_rotation_crc results: parsing output: 41/ for test: drm_read results: parsing output: 42/ for test: gem_exec_fence results: parsing output: 43/ for test: kms_dirtyfb results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_color_pipeline results: parsing output: 47/ for test: kms_cursor_crc results: parsing output: 48/ for test: kms_chamelium_hpd results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_addfb_basic results: parsing output: 51/ for test: gem_eio results: parsing output: 52/ for test: syncobj_wait results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: kms_cursor_legacy results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: i915_pm_rpm results: parsing output: 60/ for test: kms_lease results: parsing output: 61/ for test: syncobj_wait results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_pm_rpm results: parsing output: 64/ for test: api_intel_bb results: parsing output: 65/ for test: kms_content_protection results: parsing output: 66/ for test: gem_exec_flush results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: gem_lmem_swapping results: parsing output: 69/ for test: kms_rotation_crc results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: gen9_exec_parse results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_pxp results: parsing output: 77/ for test: syncobj_wait results: parsing output: 78/ for test: gem_ctx_persistence results: parsing output: 79/ for test: i915_query results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: gem_mmap_wc results: parsing output: 83/ for test: kms_flip results: parsing output: 84/ for test: gem_softpin results: parsing output: 85/ for test: gem_exec_whisper results: parsing output: 86/ for test: kms_chamelium_frames results: parsing output: 87/ for test: kms_flip_scaled_crc results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: perf_pmu results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_chamelium_edid results: parsing output: 94/ for test: gem_set_tiling_vs_blt results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_getfb results: parsing output: 98/ for test: gem_spin_batch results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_ctx_isolation results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_wait results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: gem_mmap_offset results: parsing output: 105/ for test: kms_atomic results: no output, setting notrun results: parsing output: 106/ for test: gem_exec_balancer results: no output, setting notrun results: parsing output: 107/ for test: vgem_basic results: no output, setting notrun results: parsing output: 108/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 109/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 110/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 111/ for test: kms_pm_dc results: no output, setting notrun results: parsing output: 112/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 113/ for test: gem_exec_fence results: no output, setting notrun results: parsing output: 114/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 115/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 116/ for test: gem_eio results: no output, setting notrun results: parsing output: 117/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 118/ for test: api_intel_bb results: no output, setting notrun results: parsing output: 119/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 120/ for test: kms_psr results: no output, setting notrun results: parsing output: 121/ for test: gem_partial_pwrite_pread results: no output, setting notrun results: parsing output: 122/ for test: gem_barrier_race results: no output, setting notrun results: parsing output: 123/ for test: kms_vblank results: no output, setting notrun results: parsing output: 124/ for test: kms_psr results: no output, setting notrun results: parsing output: 125/ for test: gem_exec_params results: no output, setting notrun results: parsing output: 126/ for test: kms_ccs results: no output, setting notrun results: parsing output: 127/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 128/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 129/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 130/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 131/ for test: gem_exec_reloc results: no output, setting notrun Done.