[119.179779] Initializing watchdogs [119.179826] /dev/watchdog0 [119.195584] [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] [119.200429] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [119.202860] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [119.204829] [001/156] (960s left) gem_fenced_exec_thrash (2-spare-fences) [119.270095] Subtest 2-spare-fences: SKIP (0.000s) [119.338512] [002/156] (960s left) syncobj_timeline (single-wait-all-for-submit-signaled) [119.379817] Starting subtest: single-wait-all-for-submit-signaled [119.380653] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [119.466688] [003/156] (960s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [119.571505] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [119.572398] Starting dynamic subtest: pipe-A-eDP-1 [119.696692] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s) [119.707472] Starting dynamic subtest: pipe-B-eDP-1 [121.075992] Dynamic subtest pipe-B-eDP-1: SKIP (1.378s) [121.077614] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.505s) [122.263544] [004/156] (957s left) device_reset (unbind-cold-reset-rebind) [122.310789] Starting subtest: unbind-cold-reset-rebind [122.313101] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [122.374174] [005/156] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite) [122.471296] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite [122.473249] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [122.555184] [006/156] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [122.646458] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [122.647363] Starting dynamic subtest: pipe-A-eDP-1 [123.132886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.475s) [123.141148] Starting dynamic subtest: pipe-B-eDP-1 [124.605546] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.472s) [124.613912] Starting dynamic subtest: pipe-C-eDP-1 [125.970943] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s) [125.978495] Starting dynamic subtest: pipe-D-eDP-1 [127.425295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.452s) [127.426175] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.767s) [128.588106] [007/156] (951s left) gem_mmap_gtt (basic-short) [128.641153] Subtest basic-short: SKIP (0.000s) [128.687614] [008/156] (951s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [128.783174] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [128.785608] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [128.881327] [009/156] (951s left) gem_exec_balancer (smoke) [128.941223] Starting subtest: smoke [151.623543] Subtest smoke: SUCCESS (22.671s) [152.632693] [010/156] (927s left) kms_cursor_crc (cursor-random-max-size) [152.920627] Starting subtest: cursor-random-max-size [152.923324] Subtest cursor-random-max-size: SKIP (0.000s) [153.033663] [011/156] (926s left) gem_exec_schedule (noreorder-priority) [153.219091] Starting subtest: noreorder-priority [153.220388] Starting dynamic subtest: rcs0 [154.351542] Dynamic subtest rcs0: SUCCESS (1.133s) [154.362534] Starting dynamic subtest: vcs0 [156.324185] Dynamic subtest vcs0: SUCCESS (1.962s) [156.337272] Starting dynamic subtest: vcs1 [158.306911] Dynamic subtest vcs1: SUCCESS (1.981s) [158.319482] Starting dynamic subtest: vecs0 [160.331256] Dynamic subtest vecs0: SUCCESS (2.023s) [160.340102] Starting dynamic subtest: ccs0 [161.476624] Dynamic subtest ccs0: SUCCESS (1.154s) [161.477885] Subtest noreorder-priority: SUCCESS (8.258s) [161.653557] [012/156] (918s left) kms_cursor_crc (cursor-sliding-512x512) [161.905094] Starting subtest: cursor-sliding-512x512 [161.907044] Subtest cursor-sliding-512x512: SKIP (0.001s) [162.048305] [013/156] (918s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [162.142559] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [162.143642] Starting dynamic subtest: pipe-A-default-mode [164.921592] Dynamic subtest pipe-A-default-mode: SUCCESS (2.779s) [164.922548] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.780s) [165.809186] [014/156] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [165.903844] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [165.905528] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [166.022029] [015/156] (914s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [166.413346] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [167.209495] [016/156] (913s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt) [167.309132] Starting subtest: psrhdr-farfromfence-mmap-gtt [167.310843] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [167.398944] [017/156] (912s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite) [167.499805] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite [167.501807] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s) [167.593626] [018/156] (912s left) i915_pm_freq_mult (media-freq) [167.635149] Starting subtest: media-freq [167.636112] Starting dynamic subtest: gt0 [167.637716] Dynamic subtest gt0: SKIP (0.000s) [167.644378] Starting dynamic subtest: gt1 [167.645882] Dynamic subtest gt1: SKIP (0.000s) [167.647561] Subtest media-freq: SKIP (0.001s) [167.723856] [019/156] (912s left) gem_mmap (bad-object) [167.763847] Subtest bad-object: SKIP (0.000s) [167.822412] [020/156] (912s left) gem_softpin (allocator-fork) [167.875136] Starting subtest: allocator-fork [170.086131] Subtest allocator-fork: SUCCESS (2.211s) [170.203628] [021/156] (910s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt) [170.295422] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt [170.297476] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [170.386211] [022/156] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [170.470466] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [170.472231] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [170.549394] [023/156] (909s left) kms_scaling_modes (scaling-mode-full) [170.639151] Starting subtest: scaling-mode-full [170.640067] Starting dynamic subtest: pipe-A-eDP-1 [170.743479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [170.752729] Starting dynamic subtest: pipe-B-eDP-1 [171.958582] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s) [171.968695] Starting dynamic subtest: pipe-C-eDP-1 [173.166890] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s) [173.176571] Starting dynamic subtest: pipe-D-eDP-1 [174.313263] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s) [174.314179] Subtest scaling-mode-full: SUCCESS (3.676s) [175.461422] [024/156] (905s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [175.555823] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc [175.557718] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [175.652537] [025/156] (904s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [175.743277] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [175.744160] Starting dynamic subtest: pipe-A-eDP-1 [175.753091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [175.760995] Starting dynamic subtest: pipe-B-eDP-1 [175.771143] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [175.779582] Starting dynamic subtest: pipe-C-eDP-1 [175.788216] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [175.794864] Starting dynamic subtest: pipe-D-eDP-1 [175.803211] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [175.804720] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s) [178.031435] [026/156] (902s left) kms_pipe_crc_basic (bad-source) [178.113459] Starting subtest: bad-source [178.114375] Subtest bad-source: SUCCESS (0.000s) [178.178991] [027/156] (902s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [178.269782] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [178.271547] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [178.367049] [028/156] (902s left) kms_color (ctm-max) [178.454564] Starting subtest: ctm-max [178.455472] Starting dynamic subtest: pipe-A-eDP-1 [179.171087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s) [179.178341] Starting dynamic subtest: pipe-B-eDP-1 [180.584024] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.412s) [180.591458] Starting dynamic subtest: pipe-C-eDP-1 [181.951356] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s) [181.960198] Starting dynamic subtest: pipe-D-eDP-1 [183.280187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s) [183.280953] Subtest ctm-max: SUCCESS (4.827s) [184.080990] [029/156] (896s left) kms_dp_linktrain_fallback (dsc-fallback) [184.168877] Starting subtest: dsc-fallback [184.171524] Subtest dsc-fallback: SKIP (0.000s) [184.247541] [030/156] (896s left) kms_async_flips (async-flip-hang) [184.333410] Starting subtest: async-flip-hang [184.710324] Starting dynamic subtest: pipe-A-eDP-1 [199.868767] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.157s) [200.250982] Starting dynamic subtest: pipe-B-eDP-1 [215.804953] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.559s) [216.185223] Starting dynamic subtest: pipe-C-eDP-1 [231.862267] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.682s) [232.238009] Starting dynamic subtest: pipe-D-eDP-1 [247.797032] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.563s) [247.798363] Subtest async-flip-hang: SUCCESS (63.461s) [249.025367] [031/156] (831s left) i915_drm_fdinfo (busy-check-all) [249.063496] Starting subtest: busy-check-all [249.064267] Starting dynamic subtest: rcs0 [249.069757] Dynamic subtest rcs0: SKIP (0.005s) [249.077247] Starting dynamic subtest: bcs0 [249.078790] Dynamic subtest bcs0: SKIP (0.000s) [249.086761] Starting dynamic subtest: vcs0 [249.088421] Dynamic subtest vcs0: SKIP (0.000s) [249.095370] Starting dynamic subtest: vcs1 [249.097033] Dynamic subtest vcs1: SKIP (0.000s) [249.104103] Starting dynamic subtest: vecs0 [249.106271] Dynamic subtest vecs0: SKIP (0.000s) [249.113196] Starting dynamic subtest: ccs0 [249.114796] Dynamic subtest ccs0: SKIP (0.000s) [249.116611] Subtest busy-check-all: SKIP (0.010s) [249.150252] [032/156] (831s left) sysfs_defaults (readonly) [249.217785] Starting subtest: readonly [249.219430] Starting dynamic subtest: vecs0 [249.220670] Dynamic subtest vecs0: SUCCESS (0.000s) [249.228945] Starting dynamic subtest: ccs0 [249.229898] Dynamic subtest ccs0: SUCCESS (0.000s) [249.238402] Starting dynamic subtest: vcs0 [249.239274] Dynamic subtest vcs0: SUCCESS (0.000s) [249.246253] Starting dynamic subtest: bcs0 [249.247358] Dynamic subtest bcs0: SUCCESS (0.000s) [249.254622] Starting dynamic subtest: rcs0 [249.255512] Dynamic subtest rcs0: SUCCESS (0.000s) [249.262245] Starting dynamic subtest: vcs1 [249.263078] Dynamic subtest vcs1: SUCCESS (0.000s) [249.263885] Subtest readonly: SUCCESS (0.004s) [249.328696] [033/156] (831s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw) [249.424676] Starting subtest: fbchdr-1p-pri-indfb-multidraw [249.426553] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s) [249.509420] [034/156] (831s left) kms_atomic (plane-overlay-legacy) [249.600357] Starting subtest: plane-overlay-legacy [249.601289] Starting dynamic subtest: pipe-A-eDP-1 [250.012338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.412s) [250.013175] Subtest plane-overlay-legacy: SUCCESS (0.413s) [250.852085] [035/156] (829s left) gem_ctx_engines (execute-oneforall) [250.905115] Starting subtest: execute-oneforall [251.420476] Subtest execute-oneforall: SUCCESS (0.515s) [252.421777] [036/156] (828s left) gem_pxp (create-regular-context-1) [252.548831] Starting subtest: create-regular-context-1 [252.550057] Subtest create-regular-context-1: SUCCESS (0.002s) [252.678534] [037/156] (828s left) kms_vblank (ts-continuation-modeset) [252.768856] Starting subtest: ts-continuation-modeset [252.769838] Starting dynamic subtest: pipe-A-eDP-1 [254.229562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.462s) [254.248885] Starting dynamic subtest: pipe-D-eDP-1 [256.402294] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.170s) [256.403333] Subtest ts-continuation-modeset: SUCCESS (3.635s) [257.218854] [038/156] (823s left) gem_ctx_bad_destroy (invalid-default-ctx) [257.268487] Starting subtest: invalid-default-ctx [257.269575] Subtest invalid-default-ctx: SUCCESS (0.000s) [257.328953] [039/156] (823s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [257.423094] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt [257.424858] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [257.529511] [040/156] (823s left) gem_exec_balancer (bonded-false-hang) [257.794846] Starting subtest: bonded-false-hang [257.797062] Subtest bonded-false-hang: SKIP (0.000s) [257.878496] [041/156] (823s left) gem_exec_params (invalid-bsd-ring) [257.931246] Starting subtest: invalid-bsd-ring [257.932232] Subtest invalid-bsd-ring: SUCCESS (0.000s) [258.020688] [042/156] (823s left) gem_ctx_sseu (engines) [258.078910] Subtest engines: SKIP (0.000s) [258.135728] [043/156] (822s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [258.194661] Starting subtest: invalid-multi-wait-unsubmitted-signaled [258.195856] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [258.291786] [044/156] (822s left) kms_addfb_basic (size-max) [258.378591] Starting subtest: size-max [258.379503] Subtest size-max: SUCCESS (0.000s) [258.475199] [045/156] (822s left) kms_flip (2x-modeset-vs-vblank-race) [258.556950] Starting subtest: 2x-modeset-vs-vblank-race [258.568103] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s) [258.666742] [046/156] (822s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [258.759493] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [262.658368] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.900s) [263.835948] [047/156] (817s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [263.926215] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [263.927911] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s) [264.005952] [048/156] (817s left) gem_busy (busy) [264.061705] Starting subtest: busy [264.062691] Starting dynamic subtest: all-engines [264.130941] Dynamic subtest all-engines: SUCCESS (0.069s) [264.138860] Starting dynamic subtest: rcs0 [265.320364] Dynamic subtest rcs0: SUCCESS (1.183s) [265.329341] Starting dynamic subtest: bcs0 [265.355416] Dynamic subtest bcs0: SUCCESS (0.039s) [265.364896] Starting dynamic subtest: vcs0 [265.394343] Dynamic subtest vcs0: SUCCESS (0.039s) [265.403821] Starting dynamic subtest: vcs1 [267.303938] Dynamic subtest vcs1: SUCCESS (1.899s) [267.313588] Starting dynamic subtest: vecs0 [269.352081] Dynamic subtest vecs0: SUCCESS (2.047s) [269.361544] Starting dynamic subtest: ccs0 [271.335768] Dynamic subtest ccs0: SUCCESS (1.983s) [271.336927] Subtest busy: SUCCESS (7.265s) [271.645633] [049/156] (809s left) kms_atomic_transition (plane-all-transition-fencing) [271.741988] Starting subtest: plane-all-transition-fencing [271.742937] Starting dynamic subtest: pipe-A-eDP-1 [274.238144] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [274.556475] Starting dynamic subtest: pipe-B-eDP-1 [277.777440] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.230s) [278.100925] Subtest plane-all-transition-fencing: SUCCESS (6.359s) [278.904996] [050/156] (802s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [279.019907] Starting subtest: basic-flip-after-cursor-legacy [279.943866] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.923s) [280.848718] [051/156] (800s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [280.947914] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [280.949728] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [281.023970] [052/156] (800s left) gem_mmap_gtt (basic-read-write-distinct) [281.083580] Subtest basic-read-write-distinct: SKIP (0.000s) [281.147537] [053/156] (800s left) i915_pm_rpm (gem-pread) [282.666375] Starting subtest: gem-pread [285.092792] Subtest gem-pread: SUCCESS (2.429s) [285.177405] [054/156] (796s left) kms_flip (2x-plain-flip-ts-check-interruptible) [285.274503] Starting subtest: 2x-plain-flip-ts-check-interruptible [285.286350] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [285.356598] [055/156] (796s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [285.474694] Starting subtest: flip-vs-cursor-crc-legacy [286.133947] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.659s) [286.998220] [056/156] (794s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [287.090185] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [287.091704] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [287.188732] [057/156] (794s left) kms_psr (pr-sprite-render) [287.275213] Starting subtest: pr-sprite-render [287.284715] Subtest pr-sprite-render: SKIP (0.000s) [287.339541] [058/156] (794s left) kms_psr (fbc-pr-cursor-plane-move) [287.422804] Starting subtest: fbc-pr-cursor-plane-move [287.424712] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [287.486816] [059/156] (794s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [287.593522] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [287.595352] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [287.682419] [060/156] (793s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [287.778738] Starting subtest: fbcpsr-rgb101010-draw-render [292.566495] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.789s) [292.693747] [061/156] (788s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [292.792534] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [292.794781] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [292.866997] [062/156] (788s left) kms_cursor_crc (cursor-alpha-opaque) [292.965527] Starting subtest: cursor-alpha-opaque [292.966643] Starting dynamic subtest: pipe-A-eDP-1 [293.586568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s) [293.594244] Starting dynamic subtest: pipe-D-eDP-1 [294.902403] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s) [294.903480] Subtest cursor-alpha-opaque: SUCCESS (1.936s) [295.775863] [063/156] (785s left) kms_lease (master-vs-lease) [295.864929] Starting subtest: master-vs-lease [295.866177] Subtest master-vs-lease: SUCCESS (0.002s) [295.964946] [064/156] (785s left) gem_exec_fence (syncobj-wait) [296.448721] Starting subtest: syncobj-wait [298.360969] Subtest syncobj-wait: SUCCESS (1.903s) [298.693654] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true [298.696862] [065/156] (783s left) gem_exec_whisper (basic-sync-all) [298.753558] Starting subtest: basic-sync-all [305.811741] Subtest basic-sync-all: SUCCESS (7.057s) [306.018347] [066/156] (775s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [306.119089] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [306.120101] Starting dynamic subtest: pipe-A-eDP-1 [306.937517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.815s) [306.946246] Starting dynamic subtest: pipe-B-eDP-1 [308.634552] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.696s) [308.643252] Starting dynamic subtest: pipe-C-eDP-1 [310.255453] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.619s) [310.263411] Starting dynamic subtest: pipe-D-eDP-1 [311.723747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.467s) [311.724598] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.602s) [312.921347] [067/156] (768s left) kms_big_fb (4-tiled-64bpp-rotate-0) [313.019351] Starting subtest: 4-tiled-64bpp-rotate-0 [314.611893] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.593s) [314.772187] [068/156] (767s left) sw_sync (alloc_fence_invalid_timeline) [314.799279] Starting subtest: alloc_fence_invalid_timeline [314.800463] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [314.852094] [069/156] (767s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [314.940338] Starting subtest: psr-rgb565-draw-mmap-cpu [321.787371] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.848s) [321.898231] [070/156] (760s left) gem_exec_fence (nb-await) [322.081310] Starting subtest: nb-await [322.082414] Starting dynamic subtest: rcs0 [322.142597] Dynamic subtest rcs0: SUCCESS (0.066s) [322.155506] Starting dynamic subtest: bcs0 [322.203828] Dynamic subtest bcs0: SUCCESS (0.059s) [322.217624] Starting dynamic subtest: vcs0 [322.264378] Dynamic subtest vcs0: SUCCESS (0.058s) [322.276278] Starting dynamic subtest: vcs1 [322.325416] Dynamic subtest vcs1: SUCCESS (0.058s) [322.336438] Starting dynamic subtest: vecs0 [322.384591] Dynamic subtest vecs0: SUCCESS (0.057s) [322.396717] Starting dynamic subtest: ccs0 [322.444867] Dynamic subtest ccs0: SUCCESS (0.058s) [322.448580] Subtest nb-await: SUCCESS (0.371s) [324.390620] [071/156] (757s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [324.494972] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [324.496688] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [324.588769] [072/156] (757s left) kms_psr (fbc-psr2-primary-blt) [324.674231] Starting subtest: fbc-psr2-primary-blt [324.675089] Starting dynamic subtest: eDP-1 [324.677152] Dynamic subtest eDP-1: SKIP (0.000s) [324.678989] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [324.762593] [073/156] (757s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [324.856854] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [325.957172] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.101s) [326.063991] [074/156] (756s left) prime_busy (after) [326.116468] Starting subtest: after [326.121516] Starting dynamic subtest: rcs0 [326.147771] Dynamic subtest rcs0: SUCCESS (0.028s) [326.157339] Starting dynamic subtest: bcs0 [326.189352] Dynamic subtest bcs0: SUCCESS (0.041s) [326.197791] Starting dynamic subtest: vcs0 [326.230718] Dynamic subtest vcs0: SUCCESS (0.040s) [326.240348] Starting dynamic subtest: vcs1 [326.272781] Dynamic subtest vcs1: SUCCESS (0.041s) [326.282161] Starting dynamic subtest: vecs0 [326.316271] Dynamic subtest vecs0: SUCCESS (0.039s) [326.324819] Starting dynamic subtest: ccs0 [326.353015] Dynamic subtest ccs0: SUCCESS (0.039s) [326.460439] Subtest after: SUCCESS (0.343s) [326.542419] [075/156] (755s left) syncobj_wait (multi-wait-all-for-submit-signaled) [326.585303] Starting subtest: multi-wait-all-for-submit-signaled [326.586273] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [326.669051] [076/156] (755s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [326.754235] Starting subtest: fbcpsr-tiling-y [326.755927] Subtest fbcpsr-tiling-y: SKIP (0.000s) [326.848930] [077/156] (755s left) gem_eio (unwedge-stress) [327.065444] Starting subtest: unwedge-stress [327.066468] Starting dynamic subtest: render [331.783778] Dynamic subtest render: SUCCESS (4.717s) [331.797519] Starting dynamic subtest: bsd1 [349.821279] Dynamic subtest bsd1: SUCCESS (18.035s) [349.835932] Starting dynamic subtest: bsd2 [367.804962] Dynamic subtest bsd2: SUCCESS (17.982s) [367.818666] Starting dynamic subtest: blt [367.820369] Dynamic subtest blt: SKIP (0.000s) [367.828403] Starting dynamic subtest: vebox [385.794941] Dynamic subtest vebox: SUCCESS (17.987s) [385.796331] Subtest unwedge-stress: SUCCESS (58.726s) [387.325360] [078/156] (694s left) kms_invalid_mode (bad-htotal) [387.420269] Starting subtest: bad-htotal [387.421184] Starting dynamic subtest: pipe-A-eDP-1 [387.705251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [387.713712] Starting dynamic subtest: pipe-B-eDP-1 [387.714592] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [387.722219] Starting dynamic subtest: pipe-C-eDP-1 [387.723050] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [387.730797] Starting dynamic subtest: pipe-D-eDP-1 [387.731788] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [387.732716] Subtest bad-htotal: SUCCESS (0.291s) [388.556888] [079/156] (693s left) api_intel_bb (object-reloc-purge-cache) [388.600437] Starting subtest: object-reloc-purge-cache [388.603648] Subtest object-reloc-purge-cache: SKIP (0.003s) [388.730824] [080/156] (693s left) gem_partial_pwrite_pread (writes-after-reads-display) [388.787623] Subtest writes-after-reads-display: SKIP (0.000s) [388.851633] [081/156] (693s left) kms_chamelium_color (ctm-max) [388.939868] Subtest ctm-max: SKIP (0.000s) [388.986792] [082/156] (693s left) api_intel_bb (bb-with-allocator) [389.040283] Starting subtest: bb-with-allocator [389.044441] Subtest bb-with-allocator: SUCCESS (0.006s) [389.151910] [083/156] (693s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [389.255658] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [389.257459] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [389.349817] [084/156] (693s left) gem_ctx_persistence (saturated-hostile) [389.409136] Starting subtest: saturated-hostile [389.410083] Starting dynamic subtest: rcs0 [390.231835] Dynamic subtest rcs0: SUCCESS (0.822s) [390.243892] Starting dynamic subtest: bcs0 [391.024403] Dynamic subtest bcs0: SUCCESS (0.791s) [391.036285] Starting dynamic subtest: vcs0 [391.826576] Dynamic subtest vcs0: SUCCESS (0.800s) [391.841288] Starting dynamic subtest: vcs1 [392.626197] Dynamic subtest vcs1: SUCCESS (0.797s) [392.638434] Starting dynamic subtest: vecs0 [393.422122] Dynamic subtest vecs0: SUCCESS (0.794s) [393.434377] Starting dynamic subtest: ccs0 [394.267036] Dynamic subtest ccs0: SUCCESS (0.842s) [394.268410] Subtest saturated-hostile: SUCCESS (4.859s) [394.343698] [085/156] (688s left) gem_fence_thrash (bo-copy) [394.374712] Starting subtest: bo-copy [394.401554] Subtest bo-copy: SKIP (0.026s) [394.452928] [086/156] (688s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [394.578307] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [394.580186] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [394.717064] [087/156] (687s left) gem_set_tiling_vs_blt (untiled-to-tiled) [394.768084] Subtest untiled-to-tiled: SKIP (0.000s) [394.832821] [088/156] (687s left) kms_getfb (getfb-reject-nv12) [394.913104] Starting subtest: getfb-reject-nv12 [394.914217] Subtest getfb-reject-nv12: SUCCESS (0.001s) [395.013810] [089/156] (687s left) gen9_exec_parse (allowed-all) [395.059873] Subtest allowed-all: SKIP (0.000s) [395.134972] [090/156] (687s left) gem_mmap_gtt (medium-copy-xy) [395.193368] Subtest medium-copy-XY: SKIP (0.000s) [395.259447] [091/156] (687s left) kms_plane_alpha_blend (alpha-transparent-fb) [395.350308] Starting subtest: alpha-transparent-fb [395.631636] Starting dynamic subtest: pipe-A-eDP-1 [396.264245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s) [396.273988] Starting dynamic subtest: pipe-D-eDP-1 [397.625630] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s) [397.626673] Subtest alpha-transparent-fb: SUCCESS (2.276s) [398.515996] [092/156] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [398.605539] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [406.138735] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.533s) [406.233679] [093/156] (676s left) kms_getfb (getfb-handle-zero) [406.331481] Starting subtest: getfb-handle-zero [406.332419] Subtest getfb-handle-zero: SUCCESS (0.000s) [406.435330] [094/156] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [406.525123] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [414.032555] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.509s) [414.163512] [095/156] (668s left) gem_exec_whisper (basic-forked-all) [414.219847] Starting subtest: basic-forked-all [428.262352] Subtest basic-forked-all: SUCCESS (14.031s) [428.448704] [096/156] (654s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move) [428.553825] Starting subtest: hdr-2p-scndscrn-cur-indfb-move [428.555480] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [428.648483] [097/156] (654s left) gem_ringfill (legacy-basic) [434.342224] Starting subtest: legacy-basic [434.343365] Starting dynamic subtest: default [434.394774] Dynamic subtest default: SUCCESS (0.058s) [434.406478] Starting dynamic subtest: render [434.435662] Dynamic subtest render: SUCCESS (0.040s) [434.446269] Starting dynamic subtest: bsd [434.480252] Dynamic subtest bsd: SUCCESS (0.041s) [434.491823] Starting dynamic subtest: bsd1 [434.524897] Dynamic subtest bsd1: SUCCESS (0.042s) [434.538271] Starting dynamic subtest: bsd2 [434.569712] Dynamic subtest bsd2: SUCCESS (0.042s) [434.579594] Starting dynamic subtest: blt [434.615592] Dynamic subtest blt: SUCCESS (0.043s) [434.625684] Starting dynamic subtest: vebox [434.657485] Dynamic subtest vebox: SUCCESS (0.040s) [434.660242] Subtest legacy-basic: SUCCESS (0.324s) [434.737057] [098/156] (648s left) gem_mmap_offset (close-race) [434.783144] Starting subtest: close-race [454.942513] Subtest close-race: SUCCESS (20.114s) [455.024532] [099/156] (627s left) gem_exec_schedule (submit-golden-slice) [455.081472] Starting subtest: submit-golden-slice [455.082337] Starting dynamic subtest: rcs0 [455.139825] Dynamic subtest rcs0: SUCCESS (0.058s) [455.151119] Starting dynamic subtest: bcs0 [455.201449] Dynamic subtest bcs0: SUCCESS (0.060s) [455.212595] Starting dynamic subtest: vcs0 [455.258976] Dynamic subtest vcs0: SUCCESS (0.057s) [455.267478] Starting dynamic subtest: vcs1 [455.321489] Dynamic subtest vcs1: SUCCESS (0.062s) [455.333149] Starting dynamic subtest: vecs0 [455.385588] Dynamic subtest vecs0: SUCCESS (0.062s) [455.396055] Starting dynamic subtest: ccs0 [455.443300] Dynamic subtest ccs0: SUCCESS (0.057s) [455.444673] Subtest submit-golden-slice: SUCCESS (0.362s) [456.444571] [100/156] (626s left) kms_plane_scaling (planes-upscale-factor-0-25) [456.527124] Starting subtest: planes-upscale-factor-0-25 [456.528203] Starting dynamic subtest: pipe-A [456.589626] Dynamic subtest pipe-A: SUCCESS (0.062s) [456.600403] Starting dynamic subtest: pipe-B [457.781781] Dynamic subtest pipe-B: SUCCESS (1.191s) [457.793725] Starting dynamic subtest: pipe-C [458.898316] Dynamic subtest pipe-C: SUCCESS (1.114s) [458.907269] Starting dynamic subtest: pipe-D [460.025241] Dynamic subtest pipe-D: SUCCESS (1.126s) [460.026157] Subtest planes-upscale-factor-0-25: SUCCESS (3.499s) [461.185033] [101/156] (621s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [461.271277] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [461.272176] Starting dynamic subtest: pipe-A-default-mode [462.446752] Dynamic subtest pipe-A-default-mode: SKIP (1.175s) [462.448557] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.177s) [462.614210] [102/156] (620s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite) [462.719840] Starting subtest: hdr-rgb101010-draw-pwrite [462.721844] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s) [462.822071] [103/156] (620s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt) [462.916366] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt [462.918123] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [463.034799] [104/156] (620s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [463.133629] Starting subtest: psr-2p-pri-indfb-multidraw [463.135345] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [463.229393] [105/156] (619s left) gem_watchdog (default-virtual) [463.282124] Starting subtest: default-virtual [469.577943] Subtest default-virtual: SUCCESS (6.287s) [469.649787] [106/156] (613s left) kms_flip (basic-plain-flip) [469.738810] Starting subtest: basic-plain-flip [469.740740] Starting dynamic subtest: A-eDP1 [471.426354] Dynamic subtest A-eDP1: SUCCESS (1.685s) [471.439360] Starting dynamic subtest: B-eDP1 [473.153889] Dynamic subtest B-eDP1: SUCCESS (1.724s) [473.165376] Starting dynamic subtest: C-eDP1 [474.885879] Dynamic subtest C-eDP1: SUCCESS (1.726s) [474.896514] Starting dynamic subtest: D-eDP1 [476.524939] Dynamic subtest D-eDP1: SUCCESS (1.638s) [476.526166] Subtest basic-plain-flip: SUCCESS (6.786s) [477.699469] [107/156] (605s left) gem_mmap_gtt (fault-concurrent-y) [477.753394] Subtest fault-concurrent-Y: SKIP (0.000s) [477.805267] [108/156] (605s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [477.902462] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [477.904195] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [477.995523] [109/156] (605s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [478.041581] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [478.042482] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [478.146588] [110/156] (605s left) kms_panel_fitting (legacy) [478.236523] Starting subtest: legacy [478.237466] Starting dynamic subtest: pipe-A-eDP-1 [478.733820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s) [478.762963] Starting dynamic subtest: pipe-B-eDP-1 [480.318561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.565s) [480.347056] Starting dynamic subtest: pipe-C-eDP-1 [481.815689] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.477s) [481.842622] Starting dynamic subtest: pipe-D-eDP-1 [483.367798] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s) [483.368704] Subtest legacy: SUCCESS (5.132s) [484.603512] [111/156] (598s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [484.658252] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [484.728931] [112/156] (598s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [484.817352] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [484.818257] Starting dynamic subtest: pipe-A [484.836600] Dynamic subtest pipe-A: SKIP (0.017s) [484.845088] Starting dynamic subtest: pipe-B [484.867418] Dynamic subtest pipe-B: SKIP (0.031s) [484.875868] Starting dynamic subtest: pipe-C [484.899880] Dynamic subtest pipe-C: SKIP (0.032s) [484.907951] Starting dynamic subtest: pipe-D [484.932497] Dynamic subtest pipe-D: SKIP (0.031s) [484.934625] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.114s) [485.035710] [113/156] (598s left) gem_exec_flush (basic-uc-pro-default) [485.101833] Starting subtest: basic-uc-pro-default [490.564951] Subtest basic-uc-pro-default: SUCCESS (5.463s) [490.744596] [114/156] (592s left) kms_rmfb (close-fd) [490.835274] Starting subtest: close-fd [490.836115] Starting dynamic subtest: pipe-A-eDP-1 [490.943286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [490.951542] Starting dynamic subtest: pipe-B-eDP-1 [492.162949] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s) [492.171333] Starting dynamic subtest: pipe-C-eDP-1 [493.396258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s) [493.404600] Starting dynamic subtest: pipe-D-eDP-1 [494.547632] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s) [494.548644] Subtest close-fd: SUCCESS (3.712s) [495.748435] [115/156] (587s left) kms_flip (dpms-off-confusion) [495.834247] Starting subtest: dpms-off-confusion [495.836448] Starting dynamic subtest: A-eDP1 [504.571504] Dynamic subtest A-eDP1: SUCCESS (8.709s) [504.582417] Starting dynamic subtest: B-eDP1 [513.203477] Dynamic subtest B-eDP1: SUCCESS (8.629s) [513.214635] Starting dynamic subtest: C-eDP1 [521.943425] Dynamic subtest C-eDP1: SUCCESS (8.724s) [521.954224] Starting dynamic subtest: D-eDP1 [530.570057] Dynamic subtest D-eDP1: SUCCESS (8.627s) [530.570924] Subtest dpms-off-confusion: SUCCESS (34.702s) [531.697629] [116/156] (551s left) syncobj_timeline (invalid-query-one-illegal-handle) [531.753742] Starting subtest: invalid-query-one-illegal-handle [531.754798] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [531.839803] [117/156] (551s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt) [531.931654] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt [531.933548] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [532.030178] [118/156] (551s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move) [532.124735] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move [532.126496] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [532.230187] [119/156] (551s left) gem_mmap_gtt (basic-small-copy-odd) [532.285408] Subtest basic-small-copy-odd: SKIP (0.000s) [532.345121] [120/156] (551s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [532.427111] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [532.427945] Starting dynamic subtest: pipe-A-eDP-1 [532.515915] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [532.525029] Starting dynamic subtest: pipe-B-eDP-1 [533.677534] Dynamic subtest pipe-B-eDP-1: SKIP (1.160s) [533.679485] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.252s) [534.964358] [121/156] (548s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [535.049944] Starting subtest: plane-use-after-nonblocking-unbind [535.050872] Starting dynamic subtest: pipe-A-eDP-1 [535.111763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [535.417487] Starting dynamic subtest: pipe-B-eDP-1 [536.268679] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.861s) [536.561266] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.513s) [537.432209] [122/156] (546s left) kms_cursor_crc (cursor-onscreen-max-size) [537.746716] Starting subtest: cursor-onscreen-max-size [537.751490] Subtest cursor-onscreen-max-size: SKIP (0.000s) [537.883420] [123/156] (545s left) kms_psr (psr2-no-drrs) [537.970498] Starting subtest: psr2-no-drrs [537.971433] Starting dynamic subtest: eDP-1 [539.578752] Dynamic subtest eDP-1: SUCCESS (1.607s) [539.579646] Subtest psr2-no-drrs: SUCCESS (1.608s) [540.468837] [124/156] (543s left) gem_ctx_isolation (nonpriv-switch) [540.530391] Starting subtest: nonpriv-switch [540.531474] Starting dynamic subtest: rcs0 [540.802753] Dynamic subtest rcs0: SUCCESS (0.272s) [540.813300] Starting dynamic subtest: bcs0 [541.083866] Dynamic subtest bcs0: SUCCESS (0.280s) [541.092521] Starting dynamic subtest: vcs0 [541.372089] Dynamic subtest vcs0: SUCCESS (0.287s) [541.381997] Starting dynamic subtest: vcs1 [542.541777] Dynamic subtest vcs1: SUCCESS (1.169s) [542.551418] Starting dynamic subtest: vecs0 [544.626748] Dynamic subtest vecs0: SUCCESS (2.083s) [544.637509] Starting dynamic subtest: ccs0 [546.675247] Dynamic subtest ccs0: SUCCESS (2.047s) [546.676614] Subtest nonpriv-switch: SUCCESS (6.145s) [546.907417] [125/156] (536s left) syncobj_wait (invalid-signal-bad-pad) [546.960256] Starting subtest: invalid-signal-bad-pad [546.961152] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [547.080434] [126/156] (536s left) gem_ctx_bad_destroy (invalid-pad) [547.127973] Starting subtest: invalid-pad [547.129072] Subtest invalid-pad: SUCCESS (0.000s) [547.205337] [127/156] (536s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt) [547.290950] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt [547.292820] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [547.380509] [128/156] (536s left) gem_userptr_blits (process-exit) [547.432361] Starting subtest: process-exit [547.440776] Subtest process-exit: SUCCESS (0.008s) [547.548049] [129/156] (536s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [547.636926] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [554.398404] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.762s) [554.521386] [130/156] (529s left) kms_psr (fbc-psr-primary-blt) [554.621342] Starting subtest: fbc-psr-primary-blt [554.622120] Starting dynamic subtest: eDP-1 [554.624064] Dynamic subtest eDP-1: SKIP (0.000s) [554.625617] Subtest fbc-psr-primary-blt: SKIP (0.001s) [554.691382] [131/156] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [554.784963] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [561.567908] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.784s) [561.687252] [132/156] (522s left) kms_pm_rpm (pc8-residency) [563.413137] Starting subtest: pc8-residency [563.415516] Subtest pc8-residency: SKIP (0.000s) [563.968814] [133/156] (520s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc) [564.063210] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc [564.064916] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [564.155344] [134/156] (520s left) kms_big_fb (y-tiled-8bpp-rotate-180) [564.251526] Starting subtest: y-tiled-8bpp-rotate-180 [564.253545] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [564.354103] [135/156] (519s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [564.446812] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [565.469984] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.023s) [565.601110] [136/156] (518s left) kms_plane (pixel-format-linear-modifier-source-clamping) [565.685228] Starting subtest: pixel-format-linear-modifier-source-clamping [565.713435] Starting dynamic subtest: pipe-A-plane-0 [566.279789] Dynamic subtest pipe-A-plane-0: SUCCESS (0.566s) [566.288528] Starting dynamic subtest: pipe-A-plane-3 [566.691369] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s) [567.864124] Starting dynamic subtest: pipe-B-plane-0 [568.444299] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s) [568.452959] Starting dynamic subtest: pipe-B-plane-3 [568.877663] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s) [569.187241] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.500s) [570.031153] [137/156] (514s left) kms_big_fb (x-tiled-64bpp-rotate-270) [570.122429] Starting subtest: x-tiled-64bpp-rotate-270 [570.141872] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [570.253858] [138/156] (514s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [570.337347] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [574.912975] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.576s) [576.048732] [139/156] (508s left) kms_sequence (queue-busy) [576.141377] Starting subtest: queue-busy [576.142226] Starting dynamic subtest: pipe-A-eDP-1 [578.075223] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s) [578.086873] Starting dynamic subtest: pipe-B-eDP-1 [580.655878] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.580s) [580.666235] Starting dynamic subtest: pipe-C-eDP-1 [583.267689] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s) [583.276102] Starting dynamic subtest: pipe-D-eDP-1 [585.907913] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.639s) [585.908970] Subtest queue-busy: SUCCESS (9.767s) [586.822869] [140/156] (497s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [587.229089] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [588.020974] [141/156] (496s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [588.066020] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [588.184837] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.109s) [588.262079] [142/156] (496s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [588.347822] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt [588.349846] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [588.446134] [143/156] (496s left) kms_feature_discovery (psr1) [588.525557] Starting subtest: psr1 [588.526416] Subtest psr1: SUCCESS (0.000s) [588.595867] [144/156] (496s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [588.684571] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [588.685612] Starting dynamic subtest: pipe-A-eDP-1 [588.837689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s) [588.846250] Starting dynamic subtest: pipe-B-eDP-1 [588.856220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [588.864466] Starting dynamic subtest: pipe-C-eDP-1 [588.872312] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [588.884595] Starting dynamic subtest: pipe-D-eDP-1 [588.893020] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [588.893859] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.186s) [591.110343] [145/156] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [591.201386] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [591.203265] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [591.292046] [146/156] (493s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [591.337857] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [591.340281] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [591.514844] [147/156] (493s left) gem_readwrite (beyond-eob) [591.562252] Subtest beyond-EOB: SKIP (0.000s) [591.621113] [148/156] (493s left) gem_exec_suspend (basic-s3-devices) [591.690054] Starting subtest: basic-S3-devices [591.691292] Starting dynamic subtest: smem [603.365670] Dynamic subtest smem: SUCCESS (11.666s) [603.367436] Subtest basic-S3-devices: SUCCESS (11.668s) [611.615111] [149/156] (481s left) kms_pm_dc (dc5-dpms) [612.725583] Starting subtest: dc5-dpms [614.864536] Subtest dc5-dpms: SUCCESS (2.128s) [614.942133] [150/156] (477s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render) [615.031853] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render [615.033680] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [615.123169] [151/156] (477s left) i915_query (query-topology-garbage-items) [615.165172] Starting subtest: query-topology-garbage-items [615.166216] Subtest query-topology-garbage-items: SUCCESS (0.000s) [615.287616] [152/156] (477s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw) [615.374431] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw [615.376058] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s) [615.465047] [153/156] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [615.550367] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [615.552056] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [615.640124] [154/156] (477s left) perf_pmu (module-unload)