[61.220766] Initializing watchdogs [61.220919] /dev/watchdog0 [61.235123] [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] [61.239266] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.241526] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.245395] [001/134] (960s left) kms_flip (wf_vblank-ts-check) [61.368465] Starting subtest: wf_vblank-ts-check [61.370834] Starting dynamic subtest: A-eDP1 [70.293555] Dynamic subtest A-eDP1: SUCCESS (8.928s) [70.303043] Starting dynamic subtest: B-eDP1 [79.223762] Dynamic subtest B-eDP1: SUCCESS (8.929s) [79.233128] Starting dynamic subtest: C-eDP1 [88.153338] Dynamic subtest C-eDP1: SUCCESS (8.929s) [88.160655] Starting dynamic subtest: D-eDP1 [97.088209] Dynamic subtest D-eDP1: SUCCESS (8.933s) [97.090830] Subtest wf_vblank-ts-check: SUCCESS (35.724s) [98.322395] [002/134] (923s left) kms_color (ctm-signed) [98.418595] Starting subtest: ctm-signed [98.420972] Starting dynamic subtest: pipe-A-eDP-1 [100.488526] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.071s) [100.497360] Starting dynamic subtest: pipe-B-eDP-1 [103.254086] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s) [103.265416] Starting dynamic subtest: pipe-C-eDP-1 [105.880154] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s) [105.887252] Starting dynamic subtest: pipe-D-eDP-1 [108.539498] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.659s) [108.541548] Subtest ctm-signed: SUCCESS (10.121s) [109.373632] [003/134] (912s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [109.467827] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [113.206071] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.742s) [114.375303] [004/134] (907s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [114.480051] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [114.482331] Starting dynamic subtest: pipe-A-eDP-1 [114.544142] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [114.556511] Starting dynamic subtest: pipe-B-eDP-1 [114.612994] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [114.620272] Starting dynamic subtest: pipe-C-eDP-1 [114.674438] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [114.681202] Starting dynamic subtest: pipe-D-eDP-1 [114.736813] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [114.741075] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.007s) [116.745082] [005/134] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [116.836703] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [116.840871] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [116.954426] [006/134] (904s left) gen7_exec_parse (basic-allocation) [117.013822] Subtest basic-allocation: SKIP (0.000s) [117.088214] [007/134] (904s left) syncobj_timeline (device-submit-unordered) [117.138139] Starting subtest: device-submit-unordered [117.140465] Subtest device-submit-unordered: SUCCESS (0.000s) [117.245750] [008/134] (904s left) gem_ctx_sseu (mmap-args) [117.305946] Subtest mmap-args: SKIP (0.000s) [117.391055] [009/134] (904s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [117.474193] Starting subtest: flip-primary-invalidate-overlay [129.040669] Subtest flip-primary-invalidate-overlay: SUCCESS (11.570s) [129.177792] [010/134] (892s left) kms_flip (2x-flip-vs-panning) [129.268518] Starting subtest: 2x-flip-vs-panning [129.279429] Subtest 2x-flip-vs-panning: SKIP (0.010s) [129.400738] [011/134] (892s left) syncobj_timeline (invalid-query-illegal-handle) [129.458198] Starting subtest: invalid-query-illegal-handle [129.460089] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [129.572340] [012/134] (892s left) kms_big_fb (4-tiled-32bpp-rotate-180) [129.675623] Starting subtest: 4-tiled-32bpp-rotate-180 [131.150087] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.478s) [131.301469] [013/134] (890s left) gem_exec_fence (submit67) [131.477229] Starting subtest: submit67 [131.481911] Subtest submit67: SKIP (0.000s) [133.009805] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true [133.013089] [014/134] (889s left) syncobj_wait (wait-delayed-signal) [133.068575] Starting subtest: wait-delayed-signal [133.174068] Subtest wait-delayed-signal: SUCCESS (0.104s) [133.259639] [015/134] (889s left) kms_writeback (writeback-check-output-xrgb2101010) [133.362323] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s) [133.401859] [016/134] (888s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [133.502870] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [134.448549] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.945s) [134.628423] [017/134] (887s left) kms_colorop (plane-xr24-xr24-gamma_2_2_inv_oetf-gamma_2_2_oetf) [134.752135] Subtest plane-XR24-XR24-gamma_2_2_inv_oetf-gamma_2_2_oetf: SKIP (0.000s) [134.836618] [018/134] (887s left) kms_invalid_mode (overflow-vrefresh) [134.933368] Starting subtest: overflow-vrefresh [134.935237] Starting dynamic subtest: pipe-A-eDP-1 [135.226318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [135.235175] Starting dynamic subtest: pipe-B-eDP-1 [135.237092] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [135.244036] Starting dynamic subtest: pipe-C-eDP-1 [135.246403] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [135.253315] Starting dynamic subtest: pipe-D-eDP-1 [135.255650] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [135.257966] Subtest overflow-vrefresh: SUCCESS (0.298s) [136.075935] [019/134] (886s left) gem_mmap_offset (blt-coherency) [136.134733] Starting subtest: blt-coherency [136.139907] Subtest blt-coherency: SUCCESS (0.007s) [136.299325] [020/134] (886s left) syncobj_wait (wait-all-snapshot) [136.354106] Starting subtest: wait-all-snapshot [136.434173] Subtest wait-all-snapshot: SUCCESS (0.081s) [136.531074] [021/134] (885s left) syncobj_timeline (signal-point-0) [136.584618] Starting subtest: signal-point-0 [136.586791] Subtest signal-point-0: SUCCESS (0.000s) [136.707818] [022/134] (885s left) syncobj_wait (invalid-wait-illegal-handle) [136.759875] Starting subtest: invalid-wait-illegal-handle [136.762263] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [136.886210] [023/134] (885s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [136.980858] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [136.982780] Starting dynamic subtest: pipe-A-eDP-1 [137.001904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [137.010696] Starting dynamic subtest: pipe-B-eDP-1 [137.027546] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [137.034387] Starting dynamic subtest: pipe-C-eDP-1 [137.051507] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [137.058408] Starting dynamic subtest: pipe-D-eDP-1 [137.077236] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [137.080935] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s) [139.228292] [024/134] (883s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [139.329596] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [139.334070] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [139.457513] [025/134] (883s left) syncobj_wait (wait-all-for-submit-delayed-submit) [139.514277] Starting subtest: wait-all-for-submit-delayed-submit [139.617428] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [139.702922] [026/134] (883s left) perf_pmu (enable-race) [139.739350] Starting subtest: enable-race [139.741806] Starting dynamic subtest: rcs0 [152.525080] Dynamic subtest rcs0: SUCCESS (12.785s) [152.534118] Starting dynamic subtest: bcs0 [165.265337] Dynamic subtest bcs0: SUCCESS (12.739s) [165.272764] Starting dynamic subtest: vcs0 [180.884414] Dynamic subtest vcs0: SUCCESS (15.616s) [180.893256] Starting dynamic subtest: vcs1 [196.884822] Dynamic subtest vcs1: SUCCESS (15.998s) [196.894462] Starting dynamic subtest: vecs0 [212.885126] Dynamic subtest vecs0: SUCCESS (15.999s) [212.895362] Starting dynamic subtest: ccs0 [225.633141] Dynamic subtest ccs0: SUCCESS (12.748s) [225.635617] Subtest enable-race: SUCCESS (85.892s) [225.758733] [027/134] (796s left) i915_pm_rc6_residency (rc6-fence) [225.817148] Starting subtest: rc6-fence [225.850909] Starting dynamic subtest: gt0 [238.172349] Dynamic subtest gt0: SUCCESS (12.321s) [238.182617] Starting dynamic subtest: gt1 [252.883568] Dynamic subtest gt1: SUCCESS (14.707s) [252.885913] Subtest rc6-fence: SUCCESS (27.067s) [252.978297] [028/134] (769s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [253.064716] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [253.066930] Starting dynamic subtest: pipe-A [254.191196] Dynamic subtest pipe-A: SUCCESS (1.129s) [254.198966] Starting dynamic subtest: pipe-B [256.367292] Dynamic subtest pipe-B: SUCCESS (2.175s) [256.375649] Starting dynamic subtest: pipe-C [257.594896] Dynamic subtest pipe-C: SUCCESS (1.226s) [257.604981] Starting dynamic subtest: pipe-D [258.726854] Dynamic subtest pipe-D: SUCCESS (1.131s) [258.729166] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.664s) [259.951355] [029/134] (762s left) syncobj_timeline (multi-wait-available-submitted-signaled) [260.014587] Starting subtest: multi-wait-available-submitted-signaled [260.016998] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [260.139893] [030/134] (762s left) gem_eio (in-flight-internal-immediate) [260.359021] Starting subtest: in-flight-internal-immediate [261.977348] Subtest in-flight-internal-immediate: SUCCESS (1.616s) [262.162780] [031/134] (760s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [262.253623] Starting subtest: fbcpsr-rgb101010-draw-pwrite [269.194980] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.945s) [269.343957] [032/134] (753s left) gen9_exec_parse (valid-registers) [269.409265] Subtest valid-registers: SKIP (0.000s) [269.496094] [033/134] (753s left) kms_colorop (plane-xr30-xr30-srgb_inv_eotf_lut-srgb_eotf_lut) [269.624125] Subtest plane-XR30-XR30-srgb_inv_eotf_lut-srgb_eotf_lut: SKIP (0.000s) [269.704756] [034/134] (753s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [269.819297] Starting subtest: basic-flip-after-cursor-varying-size [270.745965] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.924s) [271.635668] [035/134] (751s left) sysfs_heartbeat_interval (invalid) [271.693236] Starting subtest: invalid [271.695680] Starting dynamic subtest: vecs0 [271.697896] Dynamic subtest vecs0: SUCCESS (0.000s) [271.705861] Starting dynamic subtest: ccs0 [271.708090] Dynamic subtest ccs0: SUCCESS (0.000s) [271.715864] Starting dynamic subtest: vcs0 [271.718068] Dynamic subtest vcs0: SUCCESS (0.000s) [271.725662] Starting dynamic subtest: bcs0 [271.727892] Dynamic subtest bcs0: SUCCESS (0.000s) [271.735363] Starting dynamic subtest: rcs0 [271.737621] Dynamic subtest rcs0: SUCCESS (0.000s) [271.745650] Starting dynamic subtest: vcs1 [271.747986] Dynamic subtest vcs1: SUCCESS (0.000s) [271.749901] Subtest invalid: SUCCESS (0.004s) [271.815038] [036/134] (751s left) kms_atomic (plane-primary-overlay-mutable-zpos) [271.902718] Starting subtest: plane-primary-overlay-mutable-zpos [275.364083] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.460s) [276.578569] [037/134] (746s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [276.673584] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [276.675788] Starting dynamic subtest: pipe-A-default-mode [279.414814] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s) [279.417224] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.744s) [280.248763] [038/134] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [280.344943] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [280.349137] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [280.475199] [039/134] (742s left) gem_exec_schedule (preemptive-hang) [280.651145] Starting subtest: preemptive-hang [280.653910] Starting dynamic subtest: rcs0 [290.050721] Dynamic subtest rcs0: SUCCESS (9.396s) [290.060216] Starting dynamic subtest: bcs0 [299.005035] Dynamic subtest bcs0: SUCCESS (8.953s) [299.014683] Starting dynamic subtest: vcs0 [308.026080] Dynamic subtest vcs0: SUCCESS (9.020s) [308.037379] Starting dynamic subtest: vcs1 [317.052584] Dynamic subtest vcs1: SUCCESS (9.024s) [317.063770] Starting dynamic subtest: vecs0 [326.011205] Dynamic subtest vecs0: SUCCESS (8.959s) [326.022282] Starting dynamic subtest: ccs0 [335.038448] Dynamic subtest ccs0: SUCCESS (9.026s) [335.041062] Subtest preemptive-hang: SUCCESS (54.386s) [335.327608] [040/134] (687s left) sw_sync (sync_multi_producer_single_consumer) [335.363336] Starting subtest: sync_multi_producer_single_consumer [336.438501] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [336.510353] [041/134] (686s left) dumb_buffer (map-invalid-size) [336.581869] Starting subtest: map-invalid-size [336.584276] Subtest map-invalid-size: SUCCESS (0.000s) [336.707809] [042/134] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [336.808329] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [336.812625] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [336.932175] [043/134] (686s left) gem_exec_nop (basic-parallel) [337.011900] Starting subtest: basic-parallel [352.853096] Subtest basic-parallel: SUCCESS (15.851s) [353.111343] [044/134] (670s left) gem_media_vme [353.251622] [045/134] (670s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [353.353089] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [353.364157] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s) [353.454139] [046/134] (670s left) gem_pxp (create-regular-context-2) [353.584067] Starting subtest: create-regular-context-2 [353.586830] Subtest create-regular-context-2: SUCCESS (0.002s) [353.723049] [047/134] (669s left) gem_create (create-massive) [353.779485] Starting subtest: create-massive [353.781497] Subtest create-massive: SUCCESS (0.000s) [353.987677] [048/134] (669s left) kms_busy (extended-pageflip-hang-oldfb) [354.086955] Starting subtest: extended-pageflip-hang-oldfb [354.088923] Starting dynamic subtest: pipe-A [354.475237] Dynamic subtest pipe-A: SUCCESS (0.389s) [354.486856] Starting dynamic subtest: pipe-D [355.565664] Dynamic subtest pipe-D: SUCCESS (1.089s) [355.568042] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.481s) [356.423228] [049/134] (667s left) kms_chamelium_hpd (dp-hpd-storm) [356.802523] Subtest dp-hpd-storm: SKIP (0.000s) [357.615228] [050/134] (666s left) gem_mmap_gtt (basic) [357.676041] Subtest basic: SKIP (0.000s) [357.741463] [051/134] (665s left) perf (disabled-read-error) [357.881069] Starting subtest: disabled-read-error [357.896055] Subtest disabled-read-error: SUCCESS (0.015s) [357.942411] [052/134] (665s left) kms_selftest (drm_damage_helper) [357.979559] Starting subtest: drm_damage_helper [357.995759] Starting dynamic subtest: drm_test_damage_iter_no_damage [358.113525] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.117s) [358.121625] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [358.257557] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.141s) [358.265789] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [358.391542] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.132s) [358.399646] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [358.505299] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.113s) [358.512908] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [358.649469] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.143s) [358.657179] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [358.779921] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.129s) [358.787809] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [358.929820] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.149s) [358.938063] Starting dynamic subtest: drm_test_damage_iter_simple_damage [359.075054] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.144s) [359.084476] Starting dynamic subtest: drm_test_damage_iter_single_damage [359.213962] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.137s) [359.223699] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [359.356978] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.143s) [359.365461] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [359.502477] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.144s) [359.512227] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [359.601068] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.099s) [359.610657] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [359.738275] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.136s) [359.746099] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [359.901723] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.163s) [359.909469] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [360.043048] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.138s) [360.052649] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [360.165902] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.123s) [360.174921] Starting dynamic subtest: drm_test_damage_iter_damage [360.312875] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.147s) [360.320516] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [360.465225] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.151s) [360.473146] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [360.617357] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.150s) [360.625307] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [360.742649] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.123s) [360.752189] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [360.890799] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.147s) [360.893177] Subtest drm_damage_helper: SUCCESS (2.907s) [361.111482] [053/134] (662s left) core_auth (getclient-master-drop) [361.148976] Starting subtest: getclient-master-drop [361.172594] Subtest getclient-master-drop: SUCCESS (0.025s) [361.282734] [054/134] (662s left) gem_tiled_blits (basic) [361.350641] Subtest basic: SKIP (0.000s) [361.414692] [055/134] (662s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [361.504049] Starting subtest: primary-yf-tiled-reflect-x-90 [361.508323] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [361.598525] [056/134] (662s left) syncobj_wait (invalid-signal-illegal-handle) [361.653538] Starting subtest: invalid-signal-illegal-handle [361.655785] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [361.767065] [057/134] (662s left) gem_softpin (32b-excludes-last-page) [361.822573] Starting subtest: 32b-excludes-last-page [361.825041] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [361.980513] [058/134] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [362.083840] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [362.087477] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [362.231952] [059/134] (661s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [362.335494] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [362.339222] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [362.476379] [060/134] (661s left) gem_exec_balancer (full-pulse) [362.530713] Starting subtest: full-pulse [366.776186] Subtest full-pulse: SUCCESS (4.245s) [367.146511] [061/134] (656s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [367.242125] Starting subtest: bad-pixel-format-y-tiled-ccs [367.244375] Starting dynamic subtest: pipe-A-eDP-1 [367.267478] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [367.278447] Starting dynamic subtest: pipe-B-eDP-1 [367.299863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [367.307680] Starting dynamic subtest: pipe-C-eDP-1 [367.329491] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [367.337448] Starting dynamic subtest: pipe-D-eDP-1 [367.360045] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [367.364383] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [369.418153] [062/134] (654s left) kms_vblank (query-idle-hang) [369.511593] Starting subtest: query-idle-hang [369.513739] Starting dynamic subtest: pipe-A-eDP-1 [395.744115] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.232s) [395.759056] Starting dynamic subtest: pipe-D-eDP-1 [420.699864] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.954s) [420.702434] Subtest query-idle-hang: SUCCESS (51.190s) [421.579619] [063/134] (602s left) kms_prop_blob (blob-prop-lifetime) [421.640850] Starting subtest: blob-prop-lifetime [421.643211] Subtest blob-prop-lifetime: SUCCESS (0.003s) [421.761903] [064/134] (602s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [421.851326] Starting subtest: yf-tiled-64bpp-rotate-0 [421.855637] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [421.959122] [065/134] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [422.054770] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [422.059173] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [422.169992] [066/134] (602s left) kms_cursor_crc (cursor-onscreen-32x10) [422.341657] Starting subtest: cursor-onscreen-32x10 [422.386998] Subtest cursor-onscreen-32x10: SKIP (0.040s) [422.715905] [067/134] (601s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [422.772826] Starting subtest: multi-wait-all-for-submit-unsubmitted [422.879780] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [422.968735] [068/134] (601s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [423.026700] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [423.136315] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [423.236155] [069/134] (601s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [423.340587] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [423.344946] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [423.477303] [070/134] (600s left) syncobj_basic (create-signaled) [423.539448] Starting subtest: create-signaled [423.541656] Subtest create-signaled: SUCCESS (0.000s) [423.683055] [071/134] (600s left) sysfs_preempt_timeout (timeout) [423.747495] Starting subtest: timeout [423.749806] Starting dynamic subtest: vecs0 [432.932996] Dynamic subtest vecs0: SUCCESS (9.183s) [432.942664] Starting dynamic subtest: ccs0 [434.332151] Dynamic subtest ccs0: SUCCESS (1.398s) [434.344303] Starting dynamic subtest: vcs0 [443.940471] Dynamic subtest vcs0: SUCCESS (9.604s) [443.948969] Starting dynamic subtest: bcs0 [445.257455] Dynamic subtest bcs0: SUCCESS (1.316s) [445.269554] Starting dynamic subtest: rcs0 [446.555127] Dynamic subtest rcs0: SUCCESS (1.296s) [446.566234] Starting dynamic subtest: vcs1 [455.914671] Dynamic subtest vcs1: SUCCESS (9.356s) [455.917773] Subtest timeout: SUCCESS (32.165s) [456.003224] [072/134] (568s left) kms_pm_rpm (pm-caching) [458.143923] Starting subtest: pm-caching [458.149074] Subtest pm-caching: SKIP (0.000s) [458.534408] [073/134] (566s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [458.630635] Starting subtest: compare-crc-sanitycheck-nv12 [458.632650] Starting dynamic subtest: pipe-A-eDP-1 [459.285884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.657s) [459.296069] Starting dynamic subtest: pipe-B-eDP-1 [460.573190] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.284s) [460.582797] Starting dynamic subtest: pipe-C-eDP-1 [461.762400] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s) [461.770949] Starting dynamic subtest: pipe-D-eDP-1 [462.979877] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s) [462.982273] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.349s) [463.819062] [074/134] (560s left) kms_psr2_sf (pr-cursor-plane-update-sf) [468.789474] Starting subtest: pr-cursor-plane-update-sf [468.794070] Subtest pr-cursor-plane-update-sf: SKIP (0.002s) [469.664392] [075/134] (555s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [469.761466] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [469.765724] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [469.889934] [076/134] (554s left) kms_pm_backlight (bad-brightness) [469.974869] Starting subtest: bad-brightness [470.021341] Starting dynamic subtest: eDP-1 [470.333541] Dynamic subtest eDP-1: SUCCESS (0.309s) [470.335503] Subtest bad-brightness: SUCCESS (0.359s) [471.184436] [077/134] (553s left) gem_ctx_persistence (engines-queued) [471.246682] Starting subtest: engines-queued [471.248805] Starting dynamic subtest: rcs0 [471.365451] Dynamic subtest rcs0: SUCCESS (0.120s) [471.377178] Starting dynamic subtest: bcs0 [471.401544] Dynamic subtest bcs0: SUCCESS (0.035s) [471.409512] Starting dynamic subtest: vcs0 [472.880586] Dynamic subtest vcs0: SUCCESS (1.476s) [472.892338] Starting dynamic subtest: vcs1 [474.865862] Dynamic subtest vcs1: SUCCESS (1.983s) [474.878349] Starting dynamic subtest: vecs0 [476.850945] Dynamic subtest vecs0: SUCCESS (1.982s) [476.862744] Starting dynamic subtest: ccs0 [477.040512] Dynamic subtest ccs0: SUCCESS (0.189s) [477.042918] Subtest engines-queued: SUCCESS (5.797s) [477.191123] [078/134] (547s left) kms_ccs (random-ccs-data-y-tiled-ccs) [477.292138] Starting subtest: random-ccs-data-y-tiled-ccs [477.294573] Starting dynamic subtest: pipe-A-eDP-1 [477.318059] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [477.328915] Starting dynamic subtest: pipe-B-eDP-1 [477.352155] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [477.359913] Starting dynamic subtest: pipe-C-eDP-1 [477.382861] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [477.390773] Starting dynamic subtest: pipe-D-eDP-1 [477.414585] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [477.418643] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s) [479.531977] [079/134] (545s left) kms_chamelium_frames (hdmi-crc-single) [479.917558] Subtest hdmi-crc-single: SKIP (0.000s) [480.730815] [080/134] (544s left) sw_sync (timeline_closed_signaled) [480.765799] Starting subtest: timeline_closed_signaled [480.768122] Subtest timeline_closed_signaled: SUCCESS (0.000s) [480.833653] [081/134] (544s left) kms_fbcon_fbt (psr-suspend) [480.898607] Starting subtest: psr-suspend [530.588553] Subtest psr-suspend: SUCCESS (19.683s) [530.658701] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [530.675978] [FACT kms_fbcon_fbt (psr-suspend)] new: kernel.is_tainted.taint_warn: true [530.676882] Closing watchdogs results: parsing output: 0/ for test: kms_flip results: parsing output: 1/ for test: kms_color results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gen7_exec_parse results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: gem_ctx_sseu results: parsing output: 8/ for test: kms_psr_stress_test results: parsing output: 9/ for test: kms_flip results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: syncobj_wait results: parsing output: 14/ for test: kms_writeback results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_colorop results: parsing output: 17/ for test: kms_invalid_mode results: parsing output: 18/ for test: gem_mmap_offset results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: syncobj_wait results: parsing output: 22/ for test: kms_ccs results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: syncobj_wait results: parsing output: 25/ for test: perf_pmu results: parsing output: 26/ for test: i915_pm_rc6_residency results: parsing output: 27/ for test: kms_plane_scaling results: parsing output: 28/ for test: syncobj_timeline results: parsing output: 29/ for test: gem_eio results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gen9_exec_parse results: parsing output: 32/ for test: kms_colorop results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: sysfs_heartbeat_interval results: parsing output: 35/ for test: kms_atomic results: parsing output: 36/ for test: kms_flip_scaled_crc results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_exec_schedule results: parsing output: 39/ for test: sw_sync results: parsing output: 40/ for test: dumb_buffer results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_exec_nop results: parsing output: 43/ for test: gem_media_vme results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: gem_pxp results: parsing output: 46/ for test: gem_create results: parsing output: 47/ for test: kms_busy results: parsing output: 48/ for test: kms_chamelium_hpd results: parsing output: 49/ for test: gem_mmap_gtt results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: kms_selftest results: parsing output: 52/ for test: core_auth results: parsing output: 53/ for test: gem_tiled_blits results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: syncobj_wait results: parsing output: 56/ for test: gem_softpin results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: gem_exec_balancer results: parsing output: 60/ for test: kms_ccs results: parsing output: 61/ for test: kms_vblank results: parsing output: 62/ for test: kms_prop_blob results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: syncobj_basic results: parsing output: 70/ for test: sysfs_preempt_timeout results: parsing output: 71/ for test: kms_pm_rpm results: parsing output: 72/ for test: kms_pipe_crc_basic results: parsing output: 73/ for test: kms_psr2_sf results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_pm_backlight results: parsing output: 76/ for test: gem_ctx_persistence results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: kms_chamelium_frames results: parsing output: 79/ for test: sw_sync results: parsing output: 80/ for test: kms_fbcon_fbt results: parsing output: 81/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 82/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 83/ for test: gem_exec_schedule results: no output, setting notrun results: parsing output: 84/ for test: kms_psr2_sf results: no output, setting notrun results: parsing output: 85/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 86/ for test: gem_exec_whisper results: no output, setting notrun results: parsing output: 87/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 88/ for test: vgem_basic results: no output, setting notrun results: parsing output: 89/ for test: i915_pm_rps results: no output, setting notrun results: parsing output: 90/ for test: intel_hwmon results: no output, setting notrun results: parsing output: 91/ for test: api_intel_allocator results: no output, setting notrun results: parsing output: 92/ for test: gem_ctx_persistence results: no output, setting notrun results: parsing output: 93/ for test: kms_dsc results: no output, setting notrun results: parsing output: 94/ for test: gem_softpin results: no output, setting notrun results: parsing output: 95/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 96/ for test: perf results: no output, setting notrun results: parsing output: 97/ for test: gem_eio results: no output, setting notrun results: parsing output: 98/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 99/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 100/ for test: kms_psr results: no output, setting notrun results: parsing output: 101/ for test: sw_sync results: no output, setting notrun results: parsing output: 102/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 103/ for test: kms_rotation_crc results: no output, setting notrun results: parsing output: 104/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 105/ for test: kms_atomic_transition results: no output, setting notrun results: parsing output: 106/ for test: kms_psr results: no output, setting notrun results: parsing output: 107/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 108/ for test: kms_invalid_mode results: no output, setting notrun results: parsing output: 109/ for test: gem_readwrite results: no output, setting notrun results: parsing output: 110/ for test: kms_ccs results: no output, setting notrun results: parsing output: 111/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 112/ for test: kms_plane_lowres results: no output, setting notrun results: parsing output: 113/ for test: gem_exec_params results: no output, setting notrun results: parsing output: 114/ for test: i915_hangman results: no output, setting notrun results: parsing output: 115/ for test: kms_content_protection results: no output, setting notrun results: parsing output: 116/ for test: core_getstats results: no output, setting notrun results: parsing output: 117/ for test: gen9_exec_parse results: no output, setting notrun results: parsing output: 118/ for test: i915_query results: no output, setting notrun results: parsing output: 119/ for test: kms_draw_crc results: no output, setting notrun results: parsing output: 120/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 121/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 122/ for test: gem_exec_endless results: no output, setting notrun results: parsing output: 123/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 124/ for test: gem_pxp results: no output, setting notrun results: parsing output: 125/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 126/ for test: kms_atomic_interruptible results: no output, setting notrun results: parsing output: 127/ for test: gem_tiled_wb results: no output, setting notrun results: parsing output: 128/ for test: kms_flip results: no output, setting notrun results: parsing output: 129/ for test: kms_psr results: no output, setting notrun results: parsing output: 130/ for test: kms_flip results: no output, setting notrun results: parsing output: 131/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 132/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 133/ for test: kms_psr results: no output, setting notrun Done.