[65.902247] Initializing watchdogs
[65.902291]   /dev/watchdog0
[65.916161] [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]
[65.920465] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[65.922584] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.925952] [001/131] (960s left) i915_pm_rps (thresholds-park)
[66.017134] Starting subtest: thresholds-park
[66.021869] Subtest thresholds-park: SKIP (0.001s)
[66.122341] [002/131] (960s left) kms_psr (pr-cursor-mmap-cpu)
[66.214701] Starting subtest: pr-cursor-mmap-cpu
[66.218698] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[66.282589] [003/131] (960s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[66.392525] Starting subtest: plane-lut1d-post-ctm3x4
[66.537201] Starting dynamic subtest: pipe-A-plane-0
[66.681515] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[66.690298] Starting dynamic subtest: pipe-A-plane-1
[66.813946] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[66.821471] Starting dynamic subtest: pipe-A-plane-2
[66.970509] Dynamic subtest pipe-A-plane-2: SUCCESS (0.156s)
[68.139926] Starting dynamic subtest: pipe-B-plane-0
[68.309818] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[68.318629] Starting dynamic subtest: pipe-B-plane-1
[68.452608] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[68.462197] Starting dynamic subtest: pipe-B-plane-2
[68.586068] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[69.769414] Starting dynamic subtest: pipe-C-plane-0
[69.916795] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[69.926711] Starting dynamic subtest: pipe-C-plane-1
[70.049996] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[70.058740] Starting dynamic subtest: pipe-C-plane-2
[70.182818] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[71.409131] Starting dynamic subtest: pipe-D-plane-0
[71.530676] Dynamic subtest pipe-D-plane-0: SUCCESS (0.134s)
[71.542175] Starting dynamic subtest: pipe-D-plane-1
[71.674791] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[71.682981] Starting dynamic subtest: pipe-D-plane-2
[71.818469] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[72.108377] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.725s)
[72.984873] [004/131] (953s left) syncobj_timeline (wait-for-submit-delayed-submit)
[73.035944] Starting subtest: wait-for-submit-delayed-submit
[73.140711] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[73.212689] [005/131] (953s left) gem_exec_whisper (basic-fds-all)
[73.268468] Starting subtest: basic-fds-all
[84.857813] Subtest basic-fds-all: SUCCESS (11.587s)
[85.038268] [006/131] (941s left) gem_exec_parallel (contexts)
[85.105223] Starting subtest: contexts
[85.107317] Starting dynamic subtest: rcs0
[88.701772] Dynamic subtest rcs0: SUCCESS (3.595s)
[88.711915] Starting dynamic subtest: bcs0
[92.368630] Dynamic subtest bcs0: SUCCESS (3.666s)
[92.382717] Starting dynamic subtest: vcs0
[96.391593] Dynamic subtest vcs0: SUCCESS (4.022s)
[96.402271] Starting dynamic subtest: vcs1
[100.398780] Dynamic subtest vcs1: SUCCESS (4.006s)
[100.409520] Starting dynamic subtest: vecs0
[104.403312] Dynamic subtest vecs0: SUCCESS (4.004s)
[104.411049] Starting dynamic subtest: ccs0
[108.180811] Dynamic subtest ccs0: SUCCESS (3.776s)
[108.183788] Subtest contexts: SUCCESS (23.075s)
[108.387718] [007/131] (918s left) syncobj_wait (multi-wait-signaled)
[108.446714] Starting subtest: multi-wait-signaled
[108.449050] Subtest multi-wait-signaled: SUCCESS (0.000s)
[108.531453] [008/131] (918s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[108.630723] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[108.632935] Starting dynamic subtest: pipe-A-eDP-1
[109.433735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s)
[109.444656] Starting dynamic subtest: pipe-B-eDP-1
[110.983808] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s)
[110.992882] Starting dynamic subtest: pipe-C-eDP-1
[112.494624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[112.506905] Starting dynamic subtest: pipe-D-eDP-1
[114.081515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.588s)
[114.083428] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.445s)
[115.315107] [009/131] (911s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[115.408780] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[115.413298] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[115.499652] [010/131] (911s left) kms_cursor_edge_walk (256x256-top-edge)
[115.600063] Starting subtest: 256x256-top-edge
[115.602335] Starting dynamic subtest: pipe-A-eDP-1
[119.070132] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[119.085871] Starting dynamic subtest: pipe-D-eDP-1
[122.189955] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[122.192179] Subtest 256x256-top-edge: SUCCESS (6.591s)
[122.993806] [011/131] (903s left) kms_psr (fbc-psr-primary-render)
[123.091795] Starting subtest: fbc-psr-primary-render
[123.094126] Starting dynamic subtest: eDP-1
[123.098465] Dynamic subtest eDP-1: SKIP (0.000s)
[123.102780] Subtest fbc-psr-primary-render: SKIP (0.001s)
[123.160914] [012/131] (903s left) syncobj_eventfd (invalid-illegal-eventfd)
[123.218991] Starting subtest: invalid-illegal-eventfd
[123.220921] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[123.318957] [013/131] (903s left) gem_ctx_persistence (engines-hostile)
[123.382383] Starting subtest: engines-hostile
[123.384782] Starting dynamic subtest: rcs0
[123.526355] Dynamic subtest rcs0: SUCCESS (0.143s)
[123.537986] Starting dynamic subtest: bcs0
[123.629936] Dynamic subtest bcs0: SUCCESS (0.103s)
[123.641126] Starting dynamic subtest: vcs0
[123.722746] Dynamic subtest vcs0: SUCCESS (0.092s)
[123.733830] Starting dynamic subtest: vcs1
[123.810652] Dynamic subtest vcs1: SUCCESS (0.087s)
[123.821726] Starting dynamic subtest: vecs0
[123.917656] Dynamic subtest vecs0: SUCCESS (0.106s)
[123.927735] Starting dynamic subtest: ccs0
[124.018468] Dynamic subtest ccs0: SUCCESS (0.100s)
[124.020732] Subtest engines-hostile: SUCCESS (0.637s)
[124.093418] [014/131] (902s left) kms_psr (psr2-sprite-render)
[124.188944] Starting subtest: psr2-sprite-render
[124.190903] Starting dynamic subtest: eDP-1
[125.896478] Dynamic subtest eDP-1: SUCCESS (1.706s)
[125.898390] Subtest psr2-sprite-render: SUCCESS (1.707s)
[126.760483] [015/131] (900s left) perf_pmu (render-node-busy-idle)
[126.848701] Starting subtest: render-node-busy-idle
[126.850963] Starting dynamic subtest: rcs0
[127.538933] Dynamic subtest rcs0: SUCCESS (0.690s)
[127.553585] Starting dynamic subtest: bcs0
[128.203771] Dynamic subtest bcs0: SUCCESS (0.664s)
[128.217850] Starting dynamic subtest: vcs0
[129.878111] Dynamic subtest vcs0: SUCCESS (1.671s)
[129.889118] Starting dynamic subtest: vcs1
[131.927347] Dynamic subtest vcs1: SUCCESS (2.047s)
[131.938413] Starting dynamic subtest: vecs0
[133.910370] Dynamic subtest vecs0: SUCCESS (1.982s)
[133.921550] Starting dynamic subtest: ccs0
[134.574581] Dynamic subtest ccs0: SUCCESS (0.664s)
[134.577354] Subtest render-node-busy-idle: SUCCESS (7.727s)
[134.648257] [016/131] (892s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[134.747718] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[134.750152] Starting dynamic subtest: pipe-A
[135.107773] Dynamic subtest pipe-A: SUCCESS (0.362s)
[135.116240] Starting dynamic subtest: pipe-B
[136.585121] Dynamic subtest pipe-B: SUCCESS (1.477s)
[136.594566] Starting dynamic subtest: pipe-C
[138.004076] Dynamic subtest pipe-C: SUCCESS (1.419s)
[138.013068] Starting dynamic subtest: pipe-D
[139.436298] Dynamic subtest pipe-D: SUCCESS (1.431s)
[139.438498] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.691s)
[140.597857] [017/131] (886s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[140.716238] Starting subtest: cursorB-vs-flipB-atomic-transitions
[140.720719] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[140.876352] [018/131] (886s left) gem_workarounds (suspend-resume-fd)
[140.954504] Starting subtest: suspend-resume-fd
[157.263161] Subtest suspend-resume-fd: SUCCESS (1.297s)
[157.392929] [019/131] (869s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[157.493810] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[157.496079] Starting dynamic subtest: pipe-A-eDP-1
[157.518427] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[157.527849] Starting dynamic subtest: pipe-B-eDP-1
[157.548862] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[157.557722] Starting dynamic subtest: pipe-C-eDP-1
[157.579395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[157.588295] Starting dynamic subtest: pipe-D-eDP-1
[157.610102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[157.614475] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[159.755357] [020/131] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[159.863374] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[169.023030] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.279s)
[169.148512] [021/131] (858s left) gem_caching (read-writes)
[169.215890] Subtest read-writes: SKIP (0.000s)
[169.276176] [022/131] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[169.369381] Starting subtest: fbcpsr-2p-rte
[169.373467] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[169.465539] [023/131] (857s left) kms_chamelium_audio (dp-audio)
[169.850804] Subtest dp-audio: SKIP (0.000s)
[170.647198] [024/131] (856s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[170.756842] Starting subtest: y-tiled-16bpp-rotate-180
[170.761375] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[170.861156] [025/131] (856s left) gem_mmap_gtt (basic-small-bo)
[170.922046] Subtest basic-small-bo: SKIP (0.000s)
[170.980980] [026/131] (856s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[171.074926] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[171.077373] Starting dynamic subtest: pipe-A-eDP-1
[171.602716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[171.612980] Starting dynamic subtest: pipe-B-eDP-1
[172.952709] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.352s)
[172.962019] Starting dynamic subtest: pipe-C-eDP-1
[174.357900] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s)
[174.366772] Starting dynamic subtest: pipe-D-eDP-1
[175.677020] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[175.678912] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.591s)
[176.874199] [027/131] (850s left) kms_flip (nonblocking-read)
[176.979177] Starting subtest: nonblocking-read
[176.981471] Subtest nonblocking-read: SUCCESS (0.000s)
[177.088090] [028/131] (850s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[177.189435] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[185.754381] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.584s)
[185.878418] [029/131] (841s left) kms_addfb_basic (bad-pitch-32)
[185.944294] Starting subtest: bad-pitch-32
[185.946538] Subtest bad-pitch-32: SUCCESS (0.000s)
[186.081126] [030/131] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[186.179901] Starting subtest: fbcpsr-1p-rte
[193.186829] Subtest fbcpsr-1p-rte: SUCCESS (7.011s)
[193.335121] [031/131] (834s left) gem_exec_fence (invalid-fence-array)
[193.846558] Starting subtest: invalid-fence-array
[193.849059] Subtest invalid-fence-array: SUCCESS (0.002s)
[195.013471] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[195.018918] [032/131] (832s left) syncobj_wait (multi-wait-all-submitted-signaled)
[195.086474] Starting subtest: multi-wait-all-submitted-signaled
[195.189635] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[195.265107] [033/131] (832s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[195.361959] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[195.366053] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[195.469093] [034/131] (832s left) gem_exec_schedule (timeslicing)
[195.551032] Starting subtest: timeslicing
[195.552937] Starting dynamic subtest: rcs0
[195.565625] Dynamic subtest rcs0: SUCCESS (0.023s)
[195.576846] Starting dynamic subtest: bcs0
[195.590199] Dynamic subtest bcs0: SUCCESS (0.023s)
[195.599223] Starting dynamic subtest: vcs0
[195.610965] Dynamic subtest vcs0: SUCCESS (0.020s)
[195.620100] Starting dynamic subtest: vcs1
[195.631508] Dynamic subtest vcs1: SUCCESS (0.020s)
[195.640747] Starting dynamic subtest: vecs0
[195.651853] Dynamic subtest vecs0: SUCCESS (0.020s)
[195.660933] Starting dynamic subtest: ccs0
[195.673517] Dynamic subtest ccs0: SUCCESS (0.021s)
[195.675835] Subtest timeslicing: SUCCESS (0.132s)
[196.981244] [035/131] (830s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[197.078957] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[204.373047] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.297s)
[204.488276] [036/131] (823s left) syncobj_wait (single-wait-for-submit-signaled)
[204.535767] Starting subtest: single-wait-for-submit-signaled
[204.538058] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[204.642964] [037/131] (823s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[204.739961] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[205.774774] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.034s)
[205.919589] [038/131] (822s left) gem_spin_batch (legacy-resubmit)
[205.988799] Starting subtest: legacy-resubmit
[205.991070] Starting dynamic subtest: default
[205.995405] Dynamic subtest default: SUCCESS (0.006s)
[206.006266] Starting dynamic subtest: render
[206.008141] Dynamic subtest render: SUCCESS (0.001s)
[206.017177] Starting dynamic subtest: bsd
[206.018782] Dynamic subtest bsd: SUCCESS (0.002s)
[206.027415] Starting dynamic subtest: bsd1
[206.029033] Dynamic subtest bsd1: SUCCESS (0.001s)
[206.037072] Starting dynamic subtest: bsd2
[206.038662] Dynamic subtest bsd2: SUCCESS (0.002s)
[206.046635] Starting dynamic subtest: blt
[206.048351] Dynamic subtest blt: SUCCESS (0.002s)
[206.056281] Starting dynamic subtest: vebox
[206.057892] Dynamic subtest vebox: SUCCESS (0.002s)
[206.059495] Subtest legacy-resubmit: SUCCESS (0.022s)
[206.234487] [039/131] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[206.321228] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[206.324830] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[206.429876] [040/131] (821s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[206.485623] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[206.555072] [041/131] (821s left) gem_watchdog (default-virtual)
[206.621621] Starting subtest: default-virtual
[212.900122] Subtest default-virtual: SUCCESS (6.288s)
[212.992851] [042/131] (815s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[213.098192] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[213.102392] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[213.205116] [043/131] (814s left) kms_psr (fbc-psr2-primary-page-flip)
[213.294375] Starting subtest: fbc-psr2-primary-page-flip
[213.296798] Starting dynamic subtest: eDP-1
[213.301384] Dynamic subtest eDP-1: SKIP (0.000s)
[213.306032] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[213.368147] [044/131] (814s left) gem_exec_reloc (basic-wc-read)
[213.424572] Subtest basic-wc-read: SKIP (0.000s)
[213.493390] [045/131] (814s left) gen9_exec_parse (bb-start-out)
[213.550495] Subtest bb-start-out: SKIP (0.000s)
[213.624037] [046/131] (814s left) kms_chamelium_color (degamma)
[213.709846] Subtest degamma: SKIP (0.000s)
[213.757769] [047/131] (814s left) gem_exec_balancer (parallel-contexts)
[214.023316] Starting subtest: parallel-contexts
[216.712893] Subtest parallel-contexts: SUCCESS (2.691s)
[216.825269] [048/131] (811s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[216.917315] Starting subtest: multiplane-rotation-cropping-top
[234.424626] Subtest multiplane-rotation-cropping-top: SUCCESS (17.515s)
[234.539607] [049/131] (793s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[234.664824] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[234.668598] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[234.809824] [050/131] (793s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[234.901153] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[241.498757] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.601s)
[241.615387] [051/131] (786s left) kms_properties (plane-properties-legacy)
[241.707143] Starting subtest: plane-properties-legacy
[241.709491] Starting dynamic subtest: pipe-A-eDP-1
[242.281501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[242.291497] Starting dynamic subtest: pipe-B-eDP-1
[243.519106] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[243.529036] Starting dynamic subtest: pipe-C-eDP-1
[244.751942] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[244.762492] Starting dynamic subtest: pipe-D-eDP-1
[245.994187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[245.996391] Subtest plane-properties-legacy: SUCCESS (4.290s)
[246.790935] [052/131] (781s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[246.895388] Starting subtest: fbc-rgb565-draw-blt
[251.060896] Subtest fbc-rgb565-draw-blt: SUCCESS (4.170s)
[252.181642] [053/131] (776s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[252.293023] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[252.305260] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[252.388483] [054/131] (776s left) kms_flip (2x-flip-vs-suspend-interruptible)
[252.492614] Starting subtest: 2x-flip-vs-suspend-interruptible
[252.503945] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[252.580400] [055/131] (776s left) kms_lease (simple-lease)
[252.679443] Starting subtest: simple-lease
[252.681678] Starting dynamic subtest: pipe-A-eDP-1
[253.174094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.493s)
[253.184868] Starting dynamic subtest: pipe-B-eDP-1
[254.619633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[254.628880] Starting dynamic subtest: pipe-C-eDP-1
[256.042026] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.420s)
[256.051764] Starting dynamic subtest: pipe-D-eDP-1
[257.446704] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[257.449006] Subtest simple-lease: SUCCESS (4.767s)
[258.271581] [056/131] (770s left) gem_ccs (block-copy-compressed)
[258.339756] Starting subtest: block-copy-compressed
[258.344455] Subtest block-copy-compressed: SKIP (0.000s)
[258.435206] [057/131] (770s left) dmabuf_sync_file (export-wait-after-attach)
[258.487524] Starting subtest: export-wait-after-attach
[258.489467] Subtest export-wait-after-attach: SUCCESS (0.001s)
[258.548649] [058/131] (770s left) kms_content_protection (dp-mst-lic-type-0)
[258.689503] Starting subtest: dp-mst-lic-type-0
[258.693913] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[258.826776] [059/131] (769s left) i915_drm_fdinfo (all-busy-idle-check-all)
[258.867096] Starting subtest: all-busy-idle-check-all
[258.871631] Subtest all-busy-idle-check-all: SKIP (0.003s)
[258.931513] [060/131] (769s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[259.008728] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[259.063777] [061/131] (769s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[259.150511] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[265.882772] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.731s)
[266.007367] [062/131] (762s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[266.116396] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[270.714470] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.600s)
[271.895078] [063/131] (757s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[271.958061] Starting subtest: y-tiled-to-vebox-y-tiled
[271.962372] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[272.144962] [064/131] (756s left) kms_psr (fbc-pr-cursor-render)
[272.243862] Starting subtest: fbc-pr-cursor-render
[272.248301] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[272.316474] [065/131] (756s left) i915_hangman (engine-error-state-capture)
[272.386274] Starting subtest: engine-error-state-capture
[272.388501] Starting dynamic subtest: rcs0
[275.865100] Dynamic subtest rcs0: SUCCESS (3.478s)
[275.878302] Starting dynamic subtest: bcs0
[281.882140] Dynamic subtest bcs0: SUCCESS (6.014s)
[281.895220] Starting dynamic subtest: vcs0
[286.873304] Dynamic subtest vcs0: SUCCESS (4.988s)
[286.885428] Starting dynamic subtest: vcs1
[292.889274] Dynamic subtest vcs1: SUCCESS (6.013s)
[292.901315] Starting dynamic subtest: vecs0
[298.840994] Dynamic subtest vecs0: SUCCESS (5.949s)
[298.853543] Starting dynamic subtest: ccs0
[303.897325] Dynamic subtest ccs0: SUCCESS (5.053s)
[303.900197] Subtest engine-error-state-capture: SUCCESS (31.511s)
[304.024166] [066/131] (725s left) gem_exec_balancer (noheartbeat)
[304.292546] Starting subtest: noheartbeat
[304.297518] Subtest noheartbeat: SKIP (0.000s)
[304.412948] [067/131] (724s left) kms_pipe_crc_basic (nonblocking-crc)
[304.514656] Starting subtest: nonblocking-crc
[304.516587] Starting dynamic subtest: pipe-A-eDP-1
[305.295230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.767s)
[305.316187] Starting dynamic subtest: pipe-B-eDP-1
[306.684969] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[306.706324] Starting dynamic subtest: pipe-C-eDP-1
[308.081942] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[308.100612] Starting dynamic subtest: pipe-D-eDP-1
[309.395484] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[309.397432] Subtest nonblocking-crc: SUCCESS (4.880s)
[310.194790] [068/131] (718s left) gem_create (create-valid-nonaligned)
[310.254938] Starting subtest: create-valid-nonaligned
[310.257173] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[310.438985] [069/131] (718s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[310.488818] Starting subtest: single-wait-for-submit-available-signaled
[310.491120] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[310.591037] [070/131] (718s left) kms_atomic (atomic-plane-damage)
[310.686789] Starting subtest: atomic-plane-damage
[310.735125] Starting dynamic subtest: pipe-A-eDP-1
[311.275755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[311.278009] Subtest atomic-plane-damage: SUCCESS (0.588s)
[312.136794] [071/131] (717s left) prime_vgem (basic-gtt)
[312.218355] Starting subtest: basic-gtt
[312.222960] Subtest basic-gtt: SKIP (0.000s)
[312.326954] [072/131] (717s left) gem_exec_reloc (basic-gtt-cpu-active)
[312.392757] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[312.478651] [073/131] (716s left) kms_big_fb (x-tiled-addfb-size-overflow)
[312.572121] Starting subtest: x-tiled-addfb-size-overflow
[312.574020] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[312.657219] [074/131] (716s left) gem_pwrite (basic-exhaustion)
[312.707370] Subtest basic-exhaustion: SKIP (0.000s)
[312.777099] [075/131] (716s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[313.154755] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[313.941771] [076/131] (715s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[314.030954] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[314.033241] Starting dynamic subtest: pipe-A-eDP-1
[314.053087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[314.066080] Starting dynamic subtest: pipe-B-eDP-1
[314.085205] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[314.094127] Starting dynamic subtest: pipe-C-eDP-1
[314.113110] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[314.122060] Starting dynamic subtest: pipe-D-eDP-1
[314.140779] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[314.142852] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[316.323137] [077/131] (713s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[316.422315] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[316.426334] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[316.491393] [078/131] (713s left) prime_busy (before-wait)
[316.552441] Starting subtest: before-wait
[316.557487] Starting dynamic subtest: rcs0
[316.582756] Dynamic subtest rcs0: SUCCESS (0.027s)
[316.591941] Starting dynamic subtest: bcs0
[316.623416] Dynamic subtest bcs0: SUCCESS (0.040s)
[316.638002] Starting dynamic subtest: vcs0
[316.663992] Dynamic subtest vcs0: SUCCESS (0.039s)
[316.673765] Starting dynamic subtest: vcs1
[316.704069] Dynamic subtest vcs1: SUCCESS (0.039s)
[316.715597] Starting dynamic subtest: vecs0
[316.745417] Dynamic subtest vecs0: SUCCESS (0.040s)
[316.754781] Starting dynamic subtest: ccs0
[316.785980] Dynamic subtest ccs0: SUCCESS (0.040s)
[316.893781] Subtest before-wait: SUCCESS (0.339s)
[316.966334] [079/131] (712s left) core_debugfs (read-all-entries)
[317.027297] Starting subtest: read-all-entries
[317.108548] Subtest read-all-entries: SUCCESS (0.083s)
[317.175602] [080/131] (712s left) gem_ctx_param (root-set)
[317.234428] Starting subtest: root-set
[317.236764] Subtest root-set: SUCCESS (0.001s)
[317.323323] [081/131] (712s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[317.428748] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[317.432879] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[317.519204] [082/131] (712s left) gem_exec_reloc (basic-write-wc-active)
[317.588000] Subtest basic-write-wc-active: SKIP (0.000s)
[317.663745] [083/131] (712s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[317.785765] Starting subtest: plane-upscale-20x20-with-modifiers
[317.787999] Starting dynamic subtest: pipe-A
[318.121461] Dynamic subtest pipe-A: SUCCESS (0.338s)
[318.130348] Starting dynamic subtest: pipe-B
[319.502499] Dynamic subtest pipe-B: SUCCESS (1.380s)
[319.512753] Starting dynamic subtest: pipe-C
[320.929122] Dynamic subtest pipe-C: SUCCESS (1.426s)
[320.943602] Starting dynamic subtest: pipe-D
[322.360060] Dynamic subtest pipe-D: SUCCESS (1.430s)
[322.362343] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.578s)
[323.532546] [084/131] (706s left) gem_mmap_offset (partial-unmap)
[323.594612] Starting subtest: partial-unmap
[323.596809] Starting dynamic subtest: smem0
[324.098292] Dynamic subtest smem0: SUCCESS (0.504s)
[324.101091] Subtest partial-unmap: SUCCESS (0.505s)
[324.228849] [085/131] (705s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[324.334084] Starting subtest: 4-tiled-16bpp-rotate-90
[324.352970] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[324.467709] [086/131] (705s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[324.572081] Starting subtest: flip-vs-cursor-atomic-transitions
[332.120171] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.549s)
[332.976587] [087/131] (697s left) kms_fbcon_fbt (fbc)
[333.035936] Starting subtest: fbc
[339.397460] Subtest fbc: SUCCESS (6.362s)
[340.478118] [088/131] (689s left) kms_pm_dc (dc6-psr)
[341.570963] Starting subtest: dc6-psr
[344.551222] Subtest dc6-psr: SUCCESS (2.982s)
[345.421092] [089/131] (684s left) gem_exec_reloc (basic-cpu)
[345.492502] Subtest basic-cpu: SKIP (0.000s)
[345.578059] [090/131] (684s left) kms_flip_tiling (flip-change-tiling)
[345.668904] Starting subtest: flip-change-tiling
[345.671023] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[345.841915] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.175s)
[345.856919] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[345.987359] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.141s)
[345.999038] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[346.132110] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[346.144554] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[346.275295] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.141s)
[346.286501] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[346.419434] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[346.432352] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[346.563896] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[346.576062] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[346.697587] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[346.709747] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[346.808427] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[346.820435] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[346.942709] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[346.954566] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[347.086622] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[347.098511] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[347.230250] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[347.241773] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[347.374650] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[347.393349] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[347.508501] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[347.521099] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[347.643268] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[347.655912] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[347.753101] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[347.766205] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[347.897853] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[347.910896] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[348.041691] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[348.053094] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[348.186260] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[348.199403] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[348.319228] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[348.329929] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[348.463931] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[348.476729] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[348.608370] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[348.621275] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[348.729725] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[348.742207] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[348.874230] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[348.886500] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[349.018317] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[349.032854] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[349.151770] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.131s)
[349.163776] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[349.296229] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[349.307524] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[349.429753] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s)
[349.440435] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[349.573612] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[349.588434] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[349.696257] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[349.708300] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[349.841716] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s)
[349.857281] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[349.984535] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.140s)
[349.998099] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[350.128814] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[350.142326] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[350.274453] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[350.287120] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[350.417752] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[350.432431] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[350.562656] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[350.574901] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[350.684561] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[350.737668] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[351.983273] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.253s)
[351.996525] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[352.117564] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[352.129402] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[352.250945] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[352.263744] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[352.394711] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[352.407713] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[352.538173] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[352.555161] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[352.682221] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[352.697276] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[352.816628] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[352.828427] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[352.927759] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[352.940049] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[353.062185] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[353.073144] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[353.205232] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[353.218040] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[353.348729] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[353.363548] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[353.493149] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[353.505591] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[353.627270] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[353.638331] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[353.761572] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[353.773726] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[353.871498] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[353.883380] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[354.016406] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[354.028144] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[354.160027] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[354.172809] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[354.293629] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.131s)
[354.308886] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[354.427078] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[354.440206] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[354.560453] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[354.573312] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[354.704722] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[354.717795] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[354.826902] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[354.840239] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[354.970667] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[354.984303] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[355.115017] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[355.126613] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[355.259558] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[355.271227] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[355.404069] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[355.415675] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[355.547958] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[355.562790] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[355.703736] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.153s)
[355.716850] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[355.826341] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[355.838865] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[355.971023] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[355.983605] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[356.114638] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[356.129556] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[356.259227] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[356.272140] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[356.403669] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[356.415889] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[356.548186] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[356.561215] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[356.692551] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[356.705208] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[356.814733] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[356.869102] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[358.114703] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.253s)
[358.126897] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[358.214623] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[358.226770] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[358.314609] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[358.327286] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[358.425255] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[358.436476] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[358.535579] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[358.547528] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[358.646983] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[358.666521] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[358.747544] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[358.759700] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[358.847344] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[358.859770] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[358.947587] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[358.959833] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[359.057742] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[359.071663] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[359.168752] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[359.179543] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[359.279867] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[359.291193] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[359.390819] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.109s)
[359.404170] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[359.491060] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.097s)
[359.502462] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[359.591292] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[359.603311] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[359.702273] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[359.714260] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[359.812941] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[359.823935] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[359.924072] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[359.935378] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[360.035644] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[360.048405] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[360.135759] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[360.148507] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[360.235867] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[360.248552] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[360.346591] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[360.358118] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[360.457246] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[360.468823] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[360.568455] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[360.578733] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[360.679561] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[360.690933] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[360.779621] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[360.791049] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[360.879749] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[360.892989] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[360.990567] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[361.001633] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[361.102161] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[361.114076] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[361.212945] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[361.225781] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[361.312714] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[361.323624] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[361.423557] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[361.435496] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[361.534702] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[361.546743] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[361.645719] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[361.656861] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[361.757741] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[361.770160] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[361.868202] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[361.912851] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[363.131707] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.227s)
[363.144267] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[363.231710] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[363.244285] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[363.331234] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[363.343130] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[363.431226] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.098s)
[363.443570] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[363.542238] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[363.553321] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[363.653194] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.108s)
[363.663002] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[363.764323] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[363.778733] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[363.875561] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s)
[363.886857] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[363.975656] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[363.987765] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[364.075242] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.097s)
[364.089254] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[364.186010] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.108s)
[364.197604] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[364.285930] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s)
[364.297506] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[364.385747] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[364.398929] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[364.487418] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[364.499636] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[364.586323] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[364.597840] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[364.697436] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[364.709057] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[364.808035] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[364.820072] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[364.908015] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.098s)
[364.920237] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[365.008141] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[365.020517] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[365.108476] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[365.119809] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[365.208168] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[365.221192] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[365.319366] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[365.332136] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[365.441214] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.120s)
[365.453113] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[365.552303] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[365.567519] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[365.652025] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[365.663582] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[365.763396] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[365.775160] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[365.865646] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s)
[365.877275] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[365.974230] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[365.988293] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[366.085840] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[366.097751] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[366.196890] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[366.210560] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[366.307831] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[366.319113] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[366.419505] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[366.431106] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[366.518470] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.098s)
[366.530298] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[366.629698] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[366.641708] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[366.741452] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[366.753392] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[366.852482] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[366.885078] Subtest flip-change-tiling: SUCCESS (21.225s)
[368.039594] [091/131] (662s left) kms_async_flips (async-flip-suspend-resume)
[368.144673] Starting subtest: async-flip-suspend-resume
[368.527543] Starting dynamic subtest: pipe-A-eDP-1
[386.272460] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.936s)
[386.636167] Starting dynamic subtest: pipe-B-eDP-1
[404.261953] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.940s)
[404.640915] Starting dynamic subtest: pipe-C-eDP-1
[422.281553] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.950s)
[422.667334] Starting dynamic subtest: pipe-D-eDP-1
[440.264132] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.986s)
[440.266876] Subtest async-flip-suspend-resume: SUCCESS (13.323s)
[441.413876] [092/131] (588s left) syncobj_timeline (etime-single-wait-submitted)
[441.478265] Starting subtest: etime-single-wait-submitted
[441.580968] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[441.672036] [093/131] (588s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[441.758103] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[441.762831] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[441.868722] [094/131] (588s left) gem_render_copy (yf-tiled-ccs-to-linear)
[441.928135] Starting subtest: yf-tiled-ccs-to-linear
[441.933071] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[442.107254] [095/131] (588s left) gem_workarounds (basic-read-context)
[442.173159] Starting subtest: basic-read-context
[442.185149] Subtest basic-read-context: SUCCESS (0.013s)
[442.293837] [096/131] (588s left) perf (blocking-parameterized)
[442.412387] Starting subtest: blocking-parameterized
[462.433691] Subtest blocking-parameterized: SUCCESS (20.177s)
[462.487092] [097/131] (567s left) syncobj_wait (wait-any-snapshot)
[462.543281] Starting subtest: wait-any-snapshot
[462.623879] Subtest wait-any-snapshot: SUCCESS (0.083s)
[462.703480] [098/131] (567s left) gem_ctx_persistence (hostile)
[462.755267] Starting subtest: hostile
[472.252088] Subtest hostile: SUCCESS (9.501s)
[472.383839] [099/131] (558s left) gem_exec_whisper (basic-queues-all)
[472.456846] Starting subtest: basic-queues-all
[483.303072] Subtest basic-queues-all: SUCCESS (10.836s)
[483.491293] [100/131] (547s left) gem_exec_schedule (pi-distinct-iova)
[483.671191] Starting subtest: pi-distinct-iova
[483.673745] Starting dynamic subtest: rcs0
[483.807217] Dynamic subtest rcs0: SUCCESS (0.138s)
[483.821046] Starting dynamic subtest: vcs0
[483.900299] Dynamic subtest vcs0: SUCCESS (0.092s)
[483.914032] Starting dynamic subtest: vcs1
[483.991373] Dynamic subtest vcs1: SUCCESS (0.088s)
[484.004795] Starting dynamic subtest: vecs0
[484.077111] Dynamic subtest vecs0: SUCCESS (0.085s)
[484.090239] Starting dynamic subtest: ccs0
[484.173640] Dynamic subtest ccs0: SUCCESS (0.095s)
[484.176405] Subtest pi-distinct-iova: SUCCESS (0.507s)
[485.023797] [101/131] (545s left) i915_pm_rpm (system-suspend)
[487.041728] Starting subtest: system-suspend
[505.045115] Subtest system-suspend: SUCCESS (2.859s)
[505.418648] [102/131] (525s left) kms_plane_multiple (tiling-none)
[505.516632] Starting subtest: tiling-none
[505.519101] Starting dynamic subtest: pipe-A-eDP-1
[509.194513] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.753s)
[509.204891] Starting dynamic subtest: pipe-B-eDP-1
[513.547232] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.404s)
[513.558915] Starting dynamic subtest: pipe-C-eDP-1
[517.976327] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.458s)
[517.987930] Starting dynamic subtest: pipe-D-eDP-1
[522.308438] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.347s)
[522.310715] Subtest tiling-none: SUCCESS (16.968s)
[523.110681] [103/131] (507s left) gem_eio (in-flight-contexts-immediate)
[523.349618] Starting subtest: in-flight-contexts-immediate
[537.104501] Subtest in-flight-contexts-immediate: SUCCESS (13.774s)
[537.270601] [104/131] (493s left) gem_ctx_shared (q-promotion)
[537.346833] Starting subtest: Q-promotion
[537.349647] Starting dynamic subtest: rcs0
[537.465884] Dynamic subtest rcs0: SUCCESS (0.117s)
[537.477410] Starting dynamic subtest: vcs0
[537.578631] Dynamic subtest vcs0: SUCCESS (0.112s)
[537.598499] Starting dynamic subtest: vcs1
[537.662658] Dynamic subtest vcs1: SUCCESS (0.084s)
[537.680643] Starting dynamic subtest: vecs0
[537.747271] Dynamic subtest vecs0: SUCCESS (0.084s)
[537.762963] Starting dynamic subtest: ccs0
[537.919414] Dynamic subtest ccs0: SUCCESS (0.170s)
[537.922551] Subtest Q-promotion: SUCCESS (0.573s)
[539.152425] [105/131] (491s left) gem_ctx_engines (none)
[539.210965] Starting subtest: none
[539.213806] Subtest none: SUCCESS (0.001s)
[539.410711] [106/131] (491s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[539.518543] Starting subtest: psr2-cursor-plane-move-continuous-sf
[539.521136] Starting dynamic subtest: pipe-A-eDP-1
[549.910584] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.395s)
[549.926925] Starting dynamic subtest: pipe-B-eDP-1
[560.971925] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.063s)
[560.974713] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.460s)
[561.843191] [107/131] (469s left) gem_exec_params (dr1-dirt)
[561.911786] Starting subtest: DR1-dirt
[561.914674] Subtest DR1-dirt: SUCCESS (0.000s)
[562.013023] [108/131] (468s left) api_intel_allocator (execbuf-with-allocator)
[562.066566] Starting subtest: execbuf-with-allocator
[562.069183] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[562.222370] [109/131] (468s left) kms_scaling_modes (scaling-mode-none)
[562.311754] Starting subtest: scaling-mode-none
[562.314321] Starting dynamic subtest: pipe-A-eDP-1
[562.410170] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s)
[562.422470] Starting dynamic subtest: pipe-B-eDP-1
[562.446645] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[562.458181] Starting dynamic subtest: pipe-C-eDP-1
[562.479927] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[562.490774] Starting dynamic subtest: pipe-D-eDP-1
[562.514270] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[562.518907] Subtest scaling-mode-none: SKIP (0.203s)
[562.627173] [110/131] (468s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[562.728477] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[562.733321] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[562.833635] [111/131] (468s left) gem_workarounds (reset-fd)
[562.891627] Starting subtest: reset-fd
[563.073471] Subtest reset-fd: SUCCESS (0.182s)
[563.191790] [112/131] (467s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[563.298531] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[563.303396] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[563.407135] [113/131] (467s left) kms_invalid_mode (zero-clock)
[563.501590] Starting subtest: zero-clock
[563.504189] Starting dynamic subtest: pipe-A-eDP-1
[563.795685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[563.806823] Starting dynamic subtest: pipe-B-eDP-1
[563.809697] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[563.819944] Starting dynamic subtest: pipe-C-eDP-1
[563.822355] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[563.832439] Starting dynamic subtest: pipe-D-eDP-1
[563.835069] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[563.837822] Subtest zero-clock: SUCCESS (0.301s)
[564.682576] [114/131] (466s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[564.773140] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[564.798643] Starting dynamic subtest: pipe-A-plane-0
[565.508894] Dynamic subtest pipe-A-plane-0: SUCCESS (0.711s)
[565.519650] Starting dynamic subtest: pipe-A-plane-3
[565.986923] Dynamic subtest pipe-A-plane-3: SUCCESS (0.476s)
[567.061473] Starting dynamic subtest: pipe-B-plane-0
[567.764659] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s)
[567.774728] Starting dynamic subtest: pipe-B-plane-3
[568.253423] Dynamic subtest pipe-B-plane-3: SUCCESS (0.488s)
[568.561543] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.789s)
[569.425327] [115/131] (461s left) kms_feature_discovery (display)
[569.524741] Starting subtest: display
[569.527152] Subtest display: SUCCESS (0.000s)
[569.600563] [116/131] (461s left) gem_exec_schedule (implicit-boths)
[569.663763] Starting subtest: implicit-boths
[569.665761] Starting dynamic subtest: rcs0
[569.770710] Dynamic subtest rcs0: SUCCESS (0.116s)
[569.784047] Starting dynamic subtest: vcs0
[569.863392] Dynamic subtest vcs0: SUCCESS (0.092s)
[569.875451] Starting dynamic subtest: vcs1
[569.941729] Dynamic subtest vcs1: SUCCESS (0.077s)
[569.953606] Starting dynamic subtest: vecs0
[570.032291] Dynamic subtest vecs0: SUCCESS (0.090s)
[570.043883] Starting dynamic subtest: ccs0
[570.153955] Dynamic subtest ccs0: SUCCESS (0.120s)
[570.156739] Subtest implicit-boths: SUCCESS (0.500s)
[571.227831] [117/131] (460s left) prime_mmap (test_forked_cpu_write)
[571.285458] Starting subtest: test_forked_cpu_write
[571.288173] Starting dynamic subtest: test_forked_cpu_write-smem
[571.299504] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.016s)
[571.302176] Subtest test_forked_cpu_write: SUCCESS (0.017s)
[571.426322] [118/131] (459s left) kms_cursor_crc (cursor-random-32x10)
[571.606483] Starting subtest: cursor-random-32x10
[571.650141] Subtest cursor-random-32x10: SKIP (0.041s)
[571.921004] [119/131] (459s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[572.010662] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[572.015725] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[572.129500] [120/131] (459s left) gem_exec_flush (basic-uc-prw-default)
[572.185318] Starting subtest: basic-uc-prw-default
[577.669087] Subtest basic-uc-prw-default: SUCCESS (5.485s)
[577.875497] [121/131] (453s left) kms_prime (basic-crc-hybrid)
[577.965888] Subtest basic-crc-hybrid: SKIP (0.000s)
[578.074985] [122/131] (453s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[578.212311] Starting subtest: flip-vs-cursor-busy-crc-atomic
[579.014969] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.803s)
[579.857668] [123/131] (451s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[579.951754] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[579.957743] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[580.046384] [124/131] (451s left) kms_vblank (query-forked-busy-hang)
[580.142587] Starting subtest: query-forked-busy-hang
[580.144816] Starting dynamic subtest: pipe-A-eDP-1
[606.915665] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.776s)
[606.935510] Starting dynamic subtest: pipe-D-eDP-1
[631.859174] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.936s)
[631.861925] Subtest query-forked-busy-hang: SUCCESS (51.717s)
[632.713050] [125/131] (398s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[632.811920] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[633.814699] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.002s)
[633.940180] [126/131] (397s left) kms_flip (flip-vs-blocking-wf-vblank)
[634.043123] Starting subtest: flip-vs-blocking-wf-vblank
[634.045736] Starting dynamic subtest: A-eDP1
[642.963052] Dynamic subtest A-eDP1: SUCCESS (8.920s)
[642.977330] Starting dynamic subtest: B-eDP1
[651.895381] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[651.906900] Starting dynamic subtest: C-eDP1
[660.808096] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[660.819002] Starting dynamic subtest: D-eDP1
[669.733392] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[669.735816] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.697s)
[670.961354] [127/131] (360s left) syncobj_timeline (invalid-signal-bad-pad)
[671.010725] Starting subtest: invalid-signal-bad-pad
[671.013572] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[671.140954] [128/131] (360s left) kms_cursor_crc (cursor-onscreen-32x32)
[671.288060] Starting subtest: cursor-onscreen-32x32
[671.335617] Subtest cursor-onscreen-32x32: SKIP (0.041s)
[671.600829] [129/131] (360s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[671.653252] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[671.655390] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[671.752502] [130/131] (360s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[671.806048] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[671.910904] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[671.989912] [131/131] (359s left) kms_properties (plane-properties-atomic)
[672.083343] Starting subtest: plane-properties-atomic
[672.085653] Starting dynamic subtest: pipe-A-eDP-1
[672.630566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[672.641471] Starting dynamic subtest: pipe-B-eDP-1
[673.928374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.294s)
[673.939409] Starting dynamic subtest: pipe-C-eDP-1
[675.161593] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[675.172948] Starting dynamic subtest: pipe-D-eDP-1
[676.398546] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[676.401259] Subtest plane-properties-atomic: SUCCESS (4.319s)
[677.207888] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rps
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_color_pipeline
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_exec_whisper
results: parsing output: 5/ for test: gem_exec_parallel
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_edge_walk
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_eventfd
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_caching
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_chamelium_audio
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_spin_batch
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_pipe_b_c_ivb
results: parsing output: 40/ for test: gem_watchdog
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_chamelium_color
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_rotation_crc
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_properties
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: gem_ccs
results: parsing output: 56/ for test: dmabuf_sync_file
results: parsing output: 57/ for test: kms_content_protection
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: i915_hangman
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: kms_pipe_crc_basic
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_atomic
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_pwrite
results: parsing output: 74/ for test: kms_chamelium_hpd
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: prime_busy
results: parsing output: 78/ for test: core_debugfs
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_fbcon_fbt
results: parsing output: 87/ for test: kms_pm_dc
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_flip_tiling
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: gem_workarounds
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: gem_ctx_shared
results: parsing output: 104/ for test: gem_ctx_engines
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: api_intel_allocator
results: parsing output: 108/ for test: kms_scaling_modes
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_workarounds
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_invalid_mode
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_feature_discovery
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: prime_mmap
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_flush
results: parsing output: 120/ for test: kms_prime
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_properties
Done.