[59.502342] Initializing watchdogs [59.502397] /dev/watchdog0 [59.515262] [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] [59.519026] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.521027] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.524273] [001/130] (960s left) kms_draw_crc (draw-method-mmap-wc) [59.692645] Starting subtest: draw-method-mmap-wc [59.694518] Starting dynamic subtest: xrgb8888-untiled [59.938431] Dynamic subtest xrgb8888-untiled: SUCCESS (0.248s) [59.946654] Starting dynamic subtest: rgb565-untiled [60.150268] Dynamic subtest rgb565-untiled: SUCCESS (0.211s) [60.162835] Starting dynamic subtest: xrgb2101010-untiled [60.337906] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.189s) [60.344926] Starting dynamic subtest: xbgr16161616f-untiled [60.537985] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s) [60.546134] Starting dynamic subtest: xrgb8888-xtiled [60.660271] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [60.666637] Starting dynamic subtest: rgb565-xtiled [60.771696] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s) [60.780740] Starting dynamic subtest: xrgb2101010-xtiled [60.893609] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [60.899445] Starting dynamic subtest: xbgr16161616f-xtiled [61.004614] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s) [61.010517] Starting dynamic subtest: xrgb8888-4tiled [61.149171] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [61.156233] Starting dynamic subtest: rgb565-4tiled [61.304582] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s) [61.310078] Starting dynamic subtest: xrgb2101010-4tiled [61.438090] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [61.443965] Starting dynamic subtest: xbgr16161616f-4tiled [61.605075] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.167s) [61.607156] Subtest draw-method-mmap-wc: SUCCESS (1.915s) [61.700121] [002/130] (958s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [61.800752] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [61.804385] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [61.887349] [003/130] (958s left) kms_big_fb (4-tiled-32bpp-rotate-180) [61.995854] Starting subtest: 4-tiled-32bpp-rotate-180 [63.594992] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.600s) [63.763668] [004/130] (956s left) kms_flip (blocking-wf_vblank) [63.871321] Starting subtest: blocking-wf_vblank [63.873656] Starting dynamic subtest: A-eDP1 [72.816103] Dynamic subtest A-eDP1: SUCCESS (8.945s) [72.824916] Starting dynamic subtest: B-eDP1 [81.737832] Dynamic subtest B-eDP1: SUCCESS (8.922s) [81.746099] Starting dynamic subtest: C-eDP1 [90.656587] Dynamic subtest C-eDP1: SUCCESS (8.917s) [90.665824] Starting dynamic subtest: D-eDP1 [99.578540] Dynamic subtest D-eDP1: SUCCESS (8.922s) [99.583761] Subtest blocking-wf_vblank: SUCCESS (35.712s) [100.782204] [005/130] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [100.894254] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [100.898641] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [100.966235] [006/130] (919s left) syncobj_wait (invalid-multi-wait-unsubmitted) [101.026196] Starting subtest: invalid-multi-wait-unsubmitted [101.028451] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [101.105318] [007/130] (919s left) gem_ctx_persistence (heartbeat-hostile) [101.166293] Starting subtest: heartbeat-hostile [101.171122] Subtest heartbeat-hostile: SKIP (0.000s) [101.275137] [008/130] (918s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [101.370849] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [101.373092] Starting dynamic subtest: pipe-A-default-mode [101.657548] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [101.662287] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.283s) [102.520156] [009/130] (917s left) gem_ctx_exec (basic-invalid-context) [102.572785] Starting subtest: basic-invalid-context [102.577261] Subtest basic-invalid-context: SUCCESS (0.004s) [102.693410] [010/130] (917s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [102.824279] Starting subtest: short-flip-after-cursor-toggle [103.745689] Subtest short-flip-after-cursor-toggle: SUCCESS (0.920s) [104.542539] [011/130] (915s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [104.654169] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [107.961311] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.311s) [108.076644] [012/130] (912s left) kms_chamelium_color (ctm-0-50) [108.177625] Subtest ctm-0-50: SKIP (0.000s) [108.214880] [013/130] (912s left) kms_big_fb (linear-32bpp-rotate-0) [108.312503] Starting subtest: linear-32bpp-rotate-0 [109.977457] Subtest linear-32bpp-rotate-0: SUCCESS (1.666s) [110.169662] [014/130] (910s left) syncobj_timeline (invalid-query-zero-handles) [110.223879] Starting subtest: invalid-query-zero-handles [110.225757] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [110.340104] [015/130] (910s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [110.386818] Starting subtest: invalid-single-wait-all-unsubmitted [110.389170] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [110.489688] [016/130] (910s left) kms_psr (fbc-pr-cursor-plane-onoff) [110.578837] Starting subtest: fbc-pr-cursor-plane-onoff [110.583296] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [110.643300] [017/130] (909s left) kms_flip (2x-wf_vblank-ts-check) [110.737980] Starting subtest: 2x-wf_vblank-ts-check [110.749692] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [110.817949] [018/130] (909s left) gem_exec_basic (basic) [110.885220] Starting subtest: basic [110.887610] Starting dynamic subtest: rcs0-smem [110.889915] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [110.899060] Starting dynamic subtest: bcs0-smem [110.901150] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [110.907126] Starting dynamic subtest: vcs0-smem [110.909202] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [110.915045] Starting dynamic subtest: vcs1-smem [110.917126] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [110.923066] Starting dynamic subtest: vecs0-smem [110.925153] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [110.931070] Starting dynamic subtest: ccs0-smem [110.933211] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [110.935294] Subtest basic: SUCCESS (0.009s) [112.975193] [019/130] (907s left) kms_psr (psr2-cursor-plane-onoff) [113.069141] Starting subtest: psr2-cursor-plane-onoff [113.071498] Starting dynamic subtest: eDP-1 [114.741728] Dynamic subtest eDP-1: SUCCESS (1.672s) [114.744237] Subtest psr2-cursor-plane-onoff: SUCCESS (1.672s) [115.514129] [020/130] (905s left) gem_exec_schedule (semaphore-resolve) [115.594283] Starting subtest: semaphore-resolve [115.627441] Subtest semaphore-resolve: SUCCESS (0.038s) [115.973696] [021/130] (904s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [116.063980] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [116.066386] Starting dynamic subtest: pipe-A-eDP-1 [116.089590] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [116.098415] Starting dynamic subtest: pipe-B-eDP-1 [116.120531] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [116.128084] Starting dynamic subtest: pipe-C-eDP-1 [116.149210] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [116.155887] Starting dynamic subtest: pipe-D-eDP-1 [116.178275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [116.182367] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.002s) [118.165987] [022/130] (902s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render) [118.266088] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render [123.080254] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.816s) [123.235998] [023/130] (897s left) kms_cursor_crc (cursor-sliding-64x64) [123.393435] Starting subtest: cursor-sliding-64x64 [123.398814] Starting dynamic subtest: pipe-A-eDP-1 [126.870648] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s) [126.903874] Starting dynamic subtest: pipe-D-eDP-1 [130.928667] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.028s) [130.931084] Subtest cursor-sliding-64x64: SUCCESS (7.532s) [131.784256] [024/130] (888s left) syncobj_wait (multi-wait-all-submitted) [131.843308] Starting subtest: multi-wait-all-submitted [131.951239] Subtest multi-wait-all-submitted: SUCCESS (0.106s) [132.016679] [025/130] (888s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [132.115325] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [132.119451] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [132.222618] [026/130] (888s left) gem_ctx_bad_destroy (invalid-ctx) [132.266500] Starting subtest: invalid-ctx [132.268950] Subtest invalid-ctx: SUCCESS (0.000s) [132.320871] [027/130] (888s left) kms_pm_rpm (dpms-lpsp) [134.068690] Starting subtest: dpms-lpsp [134.561875] Subtest dpms-lpsp: SUCCESS (0.494s) [134.652394] [028/130] (886s left) kms_atomic_interruptible (universal-setplane-primary) [134.754226] Starting subtest: universal-setplane-primary [134.756646] Starting dynamic subtest: pipe-A-eDP-1 [142.148119] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.394s) [142.150085] Subtest universal-setplane-primary: SUCCESS (7.395s) [142.962835] [029/130] (877s left) gen7_exec_parse (load-register-reg) [143.029455] Subtest load-register-reg: SKIP (0.000s) [143.092812] [030/130] (877s left) sw_sync (sync_multi_producer_single_consumer) [143.124282] Starting subtest: sync_multi_producer_single_consumer [144.199982] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s) [144.249387] [031/130] (876s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [144.338094] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [144.340476] Starting dynamic subtest: pipe-A-eDP-1 [160.257864] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.468s) [160.266671] Starting dynamic subtest: pipe-B-eDP-1 [177.158129] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.330s) [177.166719] Starting dynamic subtest: pipe-C-eDP-1 [194.123726] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.253s) [194.133019] Starting dynamic subtest: pipe-D-eDP-1 [211.111877] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s) [211.113772] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.291s) [212.323424] [032/130] (867s left) gem_ccs (large-ctrl-surf-copy) [212.391294] Starting subtest: large-ctrl-surf-copy [212.395896] Subtest large-ctrl-surf-copy: SKIP (0.000s) [212.508161] [033/130] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [212.608773] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [215.284713] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.674s) [215.436674] [034/130] (864s left) kms_universal_plane (universal-plane-sanity) [215.541486] Starting subtest: universal-plane-sanity [215.543429] Starting dynamic subtest: pipe-A-eDP-1 [216.176757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s) [216.185029] Starting dynamic subtest: pipe-B-eDP-1 [217.372767] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s) [217.381851] Starting dynamic subtest: pipe-C-eDP-1 [218.603551] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s) [218.611273] Starting dynamic subtest: pipe-D-eDP-1 [219.822833] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s) [219.825334] Subtest universal-plane-sanity: SUCCESS (4.273s) [220.672148] [035/130] (858s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [220.783641] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [220.788143] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [220.883067] [036/130] (858s left) gem_userptr_blits (invalid-mmap-offset-unsync) [220.954294] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [221.082887] [037/130] (858s left) kms_busy (extended-pageflip-hang-newfb) [221.181274] Starting subtest: extended-pageflip-hang-newfb [221.183896] Starting dynamic subtest: pipe-A [247.207463] Dynamic subtest pipe-A: SUCCESS (26.007s) [247.217399] Starting dynamic subtest: pipe-D [262.179205] Dynamic subtest pipe-D: SUCCESS (14.961s) [262.182090] Subtest extended-pageflip-hang-newfb: SUCCESS (40.972s) [263.051864] [038/130] (816s left) gem_exec_reloc (basic-gtt-active) [263.126196] Subtest basic-gtt-active: SKIP (0.000s) [263.187701] [039/130] (816s left) kms_invalid_mode (bad-vsync-end) [263.284497] Starting subtest: bad-vsync-end [263.286696] Starting dynamic subtest: pipe-A-eDP-1 [263.562978] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [263.571231] Starting dynamic subtest: pipe-B-eDP-1 [263.573082] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [263.580123] Starting dynamic subtest: pipe-C-eDP-1 [263.582205] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [263.589397] Starting dynamic subtest: pipe-D-eDP-1 [263.591565] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [263.593674] Subtest bad-vsync-end: SUCCESS (0.290s) [264.383207] [040/130] (815s left) kms_psr (psr-primary-blt) [264.476170] Starting subtest: psr-primary-blt [264.478550] Starting dynamic subtest: eDP-1 [266.175446] Dynamic subtest eDP-1: SUCCESS (1.697s) [266.177798] Subtest psr-primary-blt: SUCCESS (1.698s) [267.033243] [041/130] (812s left) kms_hdr (static-toggle-dpms) [267.131294] Starting subtest: static-toggle-dpms [267.138480] Subtest static-toggle-dpms: SKIP (0.000s) [267.199162] [042/130] (812s left) gem_mmap_gtt (basic-read-write-distinct) [267.266707] Subtest basic-read-write-distinct: SKIP (0.000s) [267.321787] [043/130] (812s left) sysfs_defaults (readonly) [267.389249] Starting subtest: readonly [267.391633] Starting dynamic subtest: vecs0 [267.394217] Dynamic subtest vecs0: SUCCESS (0.000s) [267.401544] Starting dynamic subtest: ccs0 [267.403634] Dynamic subtest ccs0: SUCCESS (0.000s) [267.410703] Starting dynamic subtest: vcs0 [267.412896] Dynamic subtest vcs0: SUCCESS (0.000s) [267.420041] Starting dynamic subtest: bcs0 [267.422201] Dynamic subtest bcs0: SUCCESS (0.000s) [267.429157] Starting dynamic subtest: rcs0 [267.431435] Dynamic subtest rcs0: SUCCESS (0.000s) [267.438004] Starting dynamic subtest: vcs1 [267.439886] Dynamic subtest vcs1: SUCCESS (0.000s) [267.441730] Subtest readonly: SUCCESS (0.004s) [267.480856] [044/130] (812s left) prime_vgem (basic-read) [267.599690] Starting subtest: basic-read [267.606898] Subtest basic-read: SKIP (0.006s) [267.706783] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true [267.710201] [045/130] (812s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [267.807059] Starting subtest: plane-upscale-factor-0-25-with-rotation [267.809422] Starting dynamic subtest: pipe-A [268.034529] Dynamic subtest pipe-A: SUCCESS (0.227s) [268.043307] Starting dynamic subtest: pipe-B [269.319965] Dynamic subtest pipe-B: SUCCESS (1.284s) [269.328282] Starting dynamic subtest: pipe-C [270.643876] Dynamic subtest pipe-C: SUCCESS (1.323s) [270.652682] Starting dynamic subtest: pipe-D [271.976419] Dynamic subtest pipe-D: SUCCESS (1.331s) [271.979515] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.168s) [273.149414] [046/130] (806s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [273.214360] Starting subtest: invalid-bsd2-flag-on-vebox [273.216816] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [273.301678] [047/130] (806s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [273.361608] Starting subtest: y-tiled-to-vebox-y-tiled [273.366019] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [273.541575] [048/130] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [273.641818] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [277.984474] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.343s) [278.102444] [049/130] (801s left) kms_big_fb (y-tiled-8bpp-rotate-180) [278.210013] Starting subtest: y-tiled-8bpp-rotate-180 [278.214052] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [278.320821] [050/130] (801s left) api_intel_bb (object-reloc-keep-cache) [278.377198] Starting subtest: object-reloc-keep-cache [278.384168] Subtest object-reloc-keep-cache: SKIP (0.004s) [278.502129] [051/130] (801s left) kms_legacy_colorkey (basic) [278.602983] Starting subtest: basic [278.605163] Starting dynamic subtest: pipe-A [278.648515] Dynamic subtest pipe-A: SUCCESS (0.045s) [278.658748] Starting dynamic subtest: pipe-B [278.661112] Dynamic subtest pipe-B: SUCCESS (0.001s) [278.667980] Starting dynamic subtest: pipe-C [278.670009] Dynamic subtest pipe-C: SUCCESS (0.000s) [278.677070] Starting dynamic subtest: pipe-D [278.679150] Dynamic subtest pipe-D: SUCCESS (0.000s) [278.681419] Subtest basic: SUCCESS (0.051s) [278.710802] [052/130] (801s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [278.813153] Starting subtest: fbc-rgb101010-draw-blt [282.401754] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.590s) [282.523137] [053/130] (797s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [282.634243] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [282.638484] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [282.733215] [054/130] (797s left) testdisplay [283.104327] [055/130] (797s left) gem_ctx_persistence (smoketest) [283.162798] Starting subtest: smoketest [323.304855] Subtest smoketest: SUCCESS (40.120s) [323.374355] [056/130] (756s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [323.431366] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [323.533697] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s) [323.606067] [057/130] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [323.708026] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [326.622352] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.915s) [326.772940] [058/130] (753s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [326.880905] Starting subtest: plane-downscale-factor-0-5-with-modifiers [326.882995] Starting dynamic subtest: pipe-A [326.890929] Dynamic subtest pipe-A: SKIP (0.004s) [326.900209] Starting dynamic subtest: pipe-B [326.908003] Dynamic subtest pipe-B: SKIP (0.014s) [326.915877] Starting dynamic subtest: pipe-C [326.925252] Dynamic subtest pipe-C: SKIP (0.014s) [326.932452] Starting dynamic subtest: pipe-D [326.940112] Dynamic subtest pipe-D: SKIP (0.014s) [326.943849] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.049s) [327.017723] [059/130] (753s left) kms_color (ctm-0-25) [327.117700] Starting subtest: ctm-0-25 [327.119770] Starting dynamic subtest: pipe-A-eDP-1 [330.534768] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s) [330.543156] Starting dynamic subtest: pipe-B-eDP-1 [334.589584] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.052s) [334.598264] Starting dynamic subtest: pipe-C-eDP-1 [338.573852] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.982s) [338.586418] Starting dynamic subtest: pipe-D-eDP-1 [342.562736] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.985s) [342.565196] Subtest ctm-0-25: SUCCESS (15.435s) [343.410685] [060/130] (737s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [348.378531] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf [348.380944] Starting dynamic subtest: pipe-A-eDP-1 [365.571410] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.183s) [365.579107] Starting dynamic subtest: pipe-B-eDP-1 [382.691554] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.196s) [382.694253] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.382s) [383.479088] [061/130] (696s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [383.618287] Starting subtest: verify-pxp-execution-after-suspend-resume [390.511293] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.907s) [390.621355] [062/130] (689s left) kms_vblank (wait-idle) [390.717910] Starting subtest: wait-idle [390.720155] Starting dynamic subtest: pipe-A-eDP-1 [392.480112] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.760s) [392.492296] Starting dynamic subtest: pipe-D-eDP-1 [394.955545] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.475s) [394.957939] Subtest wait-idle: SUCCESS (4.238s) [395.771051] [063/130] (684s left) prime_vgem (busy) [395.844079] Starting subtest: busy [395.846594] Starting dynamic subtest: rcs0 [395.890155] Dynamic subtest rcs0: SUCCESS (0.046s) [395.898030] Starting dynamic subtest: bcs0 [395.980629] Dynamic subtest bcs0: SUCCESS (0.089s) [395.988708] Starting dynamic subtest: vcs0 [396.028783] Dynamic subtest vcs0: SUCCESS (0.048s) [396.036044] Starting dynamic subtest: vcs1 [396.074083] Dynamic subtest vcs1: SUCCESS (0.044s) [396.081418] Starting dynamic subtest: vecs0 [396.119311] Dynamic subtest vecs0: SUCCESS (0.045s) [396.126670] Starting dynamic subtest: ccs0 [396.165836] Dynamic subtest ccs0: SUCCESS (0.046s) [396.168146] Subtest busy: SUCCESS (0.322s) [396.289991] [064/130] (684s left) sysfs_heartbeat_interval (precise) [396.356842] Starting subtest: precise [396.359192] Starting dynamic subtest: vecs0 [404.435964] Dynamic subtest vecs0: SUCCESS (8.078s) [404.448204] Starting dynamic subtest: ccs0 [405.704150] Dynamic subtest ccs0: SUCCESS (1.269s) [405.713756] Starting dynamic subtest: vcs0 [413.411387] Dynamic subtest vcs0: SUCCESS (7.707s) [413.421829] Starting dynamic subtest: bcs0 [414.554401] Dynamic subtest bcs0: SUCCESS (1.140s) [414.563400] Starting dynamic subtest: rcs0 [415.640996] Dynamic subtest rcs0: SUCCESS (1.082s) [415.651782] Starting dynamic subtest: vcs1 [423.393692] Dynamic subtest vcs1: SUCCESS (7.755s) [423.396702] Subtest precise: SUCCESS (27.043s) [423.465173] [065/130] (657s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [423.571164] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [424.783441] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.214s) [425.004831] [066/130] (655s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [425.074644] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [425.076607] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [425.184703] [067/130] (655s left) tools_test (sysfs_l3_parity) [425.233402] Starting subtest: sysfs_l3_parity [425.305974] Subtest sysfs_l3_parity: SKIP (0.083s) [425.356366] [068/130] (655s left) gen9_exec_parse (bb-oversize) [425.415384] Subtest bb-oversize: SKIP (0.000s) [425.491701] [069/130] (655s left) api_intel_allocator (fork-simple-stress-signal) [425.549016] Starting subtest: fork-simple-stress-signal [430.956885] Subtest fork-simple-stress-signal: SUCCESS (5.411s) [431.082117] [070/130] (649s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu) [431.198606] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu [435.828447] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.633s) [435.999238] [071/130] (644s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [436.104363] Starting subtest: primary-y-tiled-reflect-x-270 [436.109014] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [436.178196] [072/130] (644s left) i915_hangman (gt-error-state-capture) [436.250841] Starting subtest: gt-error-state-capture [436.253164] Starting dynamic subtest: rcs0 [447.335845] Dynamic subtest rcs0: SUCCESS (11.086s) [447.347860] Starting dynamic subtest: bcs0 [459.367699] Dynamic subtest bcs0: SUCCESS (12.033s) [459.379946] Starting dynamic subtest: vcs0 [471.335558] Dynamic subtest vcs0: SUCCESS (11.969s) [471.347829] Starting dynamic subtest: vcs1 [483.303821] Dynamic subtest vcs1: SUCCESS (11.970s) [483.314872] Starting dynamic subtest: vecs0 [493.286974] Dynamic subtest vecs0: SUCCESS (9.985s) [493.298642] Starting dynamic subtest: ccs0 [503.335686] Dynamic subtest ccs0: SUCCESS (10.050s) [503.338521] Subtest gt-error-state-capture: SUCCESS (67.105s) [503.413985] [073/130] (577s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [503.507006] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [503.511599] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [504.594023] [074/130] (576s left) gem_exec_schedule (preempt-hang) [504.773995] Starting subtest: preempt-hang [504.776438] Starting dynamic subtest: rcs0 [504.983499] Dynamic subtest rcs0: SUCCESS (0.211s) [504.993112] Starting dynamic subtest: bcs0 [505.193054] Dynamic subtest bcs0: SUCCESS (0.207s) [505.201138] Starting dynamic subtest: vcs0 [505.393454] Dynamic subtest vcs0: SUCCESS (0.200s) [505.401665] Starting dynamic subtest: vcs1 [505.605901] Dynamic subtest vcs1: SUCCESS (0.211s) [505.617230] Starting dynamic subtest: vecs0 [505.818244] Dynamic subtest vecs0: SUCCESS (0.213s) [505.826395] Starting dynamic subtest: ccs0 [506.037247] Dynamic subtest ccs0: SUCCESS (0.219s) [506.039110] Subtest preempt-hang: SUCCESS (1.264s) [506.483851] [075/130] (574s left) kms_flip (2x-flip-vs-rmfb) [506.587941] Starting subtest: 2x-flip-vs-rmfb [506.598875] Subtest 2x-flip-vs-rmfb: SKIP (0.010s) [506.702430] [076/130] (574s left) gem_eio (kms) [506.958025] Starting subtest: kms [528.761018] Subtest kms: SUCCESS (21.813s) [529.926953] [077/130] (551s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [530.453133] Starting subtest: syncobj-timeline-multiple-ext-nodes [530.455640] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s) [531.508332] [078/130] (549s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [531.606465] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [538.028266] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.428s) [538.136772] [079/130] (542s left) gem_ctx_param (invalid-size-set) [538.191739] Starting subtest: invalid-size-set [538.194236] Subtest invalid-size-set: SUCCESS (0.001s) [538.287279] [080/130] (542s left) kms_cursor_crc (cursor-onscreen-128x42) [538.481732] Starting subtest: cursor-onscreen-128x42 [538.519260] Subtest cursor-onscreen-128x42: SKIP (0.035s) [538.722470] [081/130] (542s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [538.846904] Starting subtest: modeset-atomic-cursor-hotspot [538.851352] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [538.941302] [082/130] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [539.035318] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [543.828984] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.797s) [543.947198] [083/130] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [544.059559] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [544.063725] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [544.171582] [084/130] (537s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [544.269306] Starting subtest: invalidate-primary-flip-overlay [555.073930] Subtest invalidate-primary-flip-overlay: SUCCESS (10.810s) [555.202841] [085/130] (526s left) gem_exec_whisper (basic-contexts-forked) [555.274249] Starting subtest: basic-contexts-forked [579.613225] Subtest basic-contexts-forked: SUCCESS (24.345s) [579.793047] [086/130] (501s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [579.847879] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [579.850207] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [579.957960] [087/130] (501s left) kms_big_fb (linear-64bpp-rotate-90) [580.052807] Starting subtest: linear-64bpp-rotate-90 [580.071287] Subtest linear-64bpp-rotate-90: SKIP (0.018s) [580.191556] [088/130] (501s left) gem_mmap_gtt (cpuset-big-copy) [580.249428] Subtest cpuset-big-copy: SKIP (0.000s) [580.310413] [089/130] (501s left) i915_pm_rpm (gem-idle) [582.547197] Starting subtest: gem-idle [588.766431] Subtest gem-idle: SUCCESS (6.220s) [589.070845] [090/130] (492s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [590.421007] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [590.423364] Starting dynamic subtest: pipe-A [590.438789] Dynamic subtest pipe-A: SKIP (0.011s) [590.448187] Starting dynamic subtest: pipe-B [590.460692] Dynamic subtest pipe-B: SKIP (0.024s) [590.469734] Starting dynamic subtest: pipe-C [590.483853] Dynamic subtest pipe-C: SKIP (0.021s) [590.494569] Starting dynamic subtest: pipe-D [590.503735] Dynamic subtest pipe-D: SKIP (0.020s) [590.507679] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.078s) [590.608800] [091/130] (490s left) sw_sync (sync_expired_merge) [590.654667] Starting subtest: sync_expired_merge [591.727248] Subtest sync_expired_merge: SUCCESS (1.074s) [591.783366] [092/130] (489s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [591.881725] Starting subtest: yf-tiled-64bpp-rotate-90 [591.886134] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [591.995583] [093/130] (489s left) gem_eio (in-flight-1us) [592.212640] Starting subtest: in-flight-1us [600.277536] Subtest in-flight-1us: SUCCESS (8.068s) [600.393938] [094/130] (481s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [600.527751] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [600.531982] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [600.632258] [095/130] (480s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [600.747168] Starting subtest: short-flip-before-cursor-atomic-transitions [601.712736] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.962s) [602.581821] [096/130] (479s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [607.531989] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [607.534689] Starting dynamic subtest: pipe-A-eDP-1 [608.339466] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s) [608.351054] Starting dynamic subtest: pipe-B-eDP-1 [609.462626] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s) [609.467206] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.928s) [610.640338] [097/130] (470s left) kms_plane_alpha_blend (alpha-transparent-fb) [610.739081] Starting subtest: alpha-transparent-fb [611.155614] Starting dynamic subtest: pipe-A-eDP-1 [611.720167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [611.728597] Starting dynamic subtest: pipe-D-eDP-1 [613.063394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s) [613.065934] Subtest alpha-transparent-fb: SUCCESS (2.325s) [613.891064] [098/130] (467s left) gem_mmap_offset (clear-via-pagefault) [613.959050] Starting subtest: clear-via-pagefault [613.961235] Starting dynamic subtest: smem0 [681.956389] Dynamic subtest smem0: SUCCESS (68.018s) [681.958440] Subtest clear-via-pagefault: SUCCESS (68.020s) [682.303468] [099/130] (399s left) gem_partial_pwrite_pread (reads-snoop) [682.371589] Subtest reads-snoop: SKIP (0.000s) [682.463547] [100/130] (399s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [682.562212] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [682.564534] Starting dynamic subtest: pipe-A-default-mode [682.848336] Dynamic subtest pipe-A-default-mode: SKIP (0.281s) [682.852963] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.283s) [683.682248] [101/130] (398s left) kms_flip (flip-vs-suspend) [683.789244] Starting subtest: flip-vs-suspend [683.791605] Starting dynamic subtest: A-eDP1 [733.006158] Dynamic subtest A-eDP1: SUCCESS (4.449s) [733.023159] Starting dynamic subtest: B-eDP1 [781.996310] Dynamic subtest B-eDP1: SUCCESS (4.280s) [782.006561] Starting dynamic subtest: C-eDP1 [831.011251] Dynamic subtest C-eDP1: SUCCESS (4.338s) [831.024469] Starting dynamic subtest: D-eDP1 [880.012797] Dynamic subtest D-eDP1: SUCCESS (4.312s) [880.017811] Subtest flip-vs-suspend: SUCCESS (17.386s) [881.223675] [102/130] (379s left) gem_exec_params (invalid-batch-start-offset) [881.287494] Starting subtest: invalid-batch-start-offset [881.290353] Subtest invalid-batch-start-offset: SUCCESS (0.002s) [881.425633] [103/130] (379s left) kms_psr (fbc-psr2-sprite-plane-move) [881.531056] Starting subtest: fbc-psr2-sprite-plane-move [881.533487] Starting dynamic subtest: eDP-1 [881.538115] Dynamic subtest eDP-1: SKIP (0.000s) [881.542979] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [881.597452] [104/130] (379s left) gem_eio (hibernate) [881.815765] Starting subtest: hibernate [896.911981] Subtest hibernate: SUCCESS (15.096s) [897.035232] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2439 [max: 8192] direct dependencies: 29190 [max: 524288] indirect dependencies: 246904 all direct dependencies: 641859 dependency chains: 46349 [max: 524288] dependency chain hlocks used: 206105 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 470 in-softirq chains: 1076 in-process chains: 44803 stack-trace entries: 303305 [max: 524288] number of stack traces: 13857 number of stack hash chains: 9287 combined max dependencies: 1252754188 hardirq-safe locks: 138 hardirq-unsafe locks: 1383 softirq-safe locks: 285 softirq-unsafe locks: 1274 irq-safe locks: 305 irq-unsafe locks: 1383 hardirq-read-safe locks: 5 hardirq-read-unsafe locks: 495 softirq-read-safe locks: 10 softirq-read-unsafe locks: 490 irq-read-safe locks: 10 irq-read-unsafe locks: 495 uncategorized locks: 394 unused locks: 1 max locking depth: 16 max bfs queue depth: 441 max lock class index: 2438 debug_locks: 0 zapped classes: 3 zapped lock chains: 157 large chain blocks: 1 [897.047507] Closing watchdogs Done.