[59.908884] Initializing watchdogs
[59.908932]   /dev/watchdog0
[59.922601] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.927137] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.929280] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.932657] [001/134] (960s left) dumb_buffer (map-uaf)
[60.014782] Starting subtest: map-uaf
[60.019182] Subtest map-uaf: SUCCESS (0.005s)
[60.145976] [002/134] (960s left) kms_cursor_crc (cursor-size-hints)
[60.288478] Starting subtest: cursor-size-hints
[60.290674] Starting dynamic subtest: pipe-A-eDP-1
[60.944386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.658s)
[60.952553] Starting dynamic subtest: pipe-D-eDP-1
[62.187643] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[62.189646] Subtest cursor-size-hints: SUCCESS (1.907s)
[63.000900] [003/134] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[63.096873] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[63.101371] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[64.214505] [004/134] (956s left) syncobj_wait (single-wait-for-submit-signaled)
[64.273049] Starting subtest: single-wait-for-submit-signaled
[64.274993] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[64.394696] [005/134] (956s left) gem_workarounds (basic-read)
[64.457147] Starting subtest: basic-read
[64.468548] Subtest basic-read: SUCCESS (0.011s)
[64.588242] [006/134] (956s left) kms_dp_linktrain_fallback (dsc-fallback)
[64.679113] Starting subtest: dsc-fallback
[64.685767] Subtest dsc-fallback: SKIP (0.000s)
[64.759764] [007/134] (955s left) gem_create (create-invalid-size)
[64.819130] Starting subtest: create-invalid-size
[64.821413] Subtest create-invalid-size: SUCCESS (0.000s)
[65.004270] [008/134] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[65.108571] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[65.112749] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[65.233857] [009/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[65.340394] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[71.875677] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.552s)
[72.030593] [010/134] (948s left) gem_partial_pwrite_pread (reads)
[72.099718] Subtest reads: SKIP (0.000s)
[72.185895] [011/134] (948s left) api_intel_bb (object-reloc-purge-cache)
[72.239329] Starting subtest: object-reloc-purge-cache
[72.243689] Subtest object-reloc-purge-cache: SKIP (0.002s)
[72.341581] [012/134] (948s left) gem_render_copy (y-tiled-to-vebox-linear)
[72.403565] Starting subtest: y-tiled-to-vebox-linear
[72.407771] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[72.594217] [013/134] (948s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[72.699392] Starting subtest: 2x-absolute-wf_vblank-interruptible
[72.712517] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.013s)
[72.841577] [014/134] (948s left) gem_softpin (allocator-nopin)
[72.906259] Starting subtest: allocator-nopin
[72.996949] Subtest allocator-nopin: SUCCESS (0.090s)
[73.142428] [015/134] (947s left) kms_pm_rpm (drm-resources-equal)
[75.071711] Starting subtest: drm-resources-equal
[80.134264] Subtest drm-resources-equal: SUCCESS (5.065s)
[80.230445] [016/134] (940s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[80.334782] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[80.337267] Starting dynamic subtest: pipe-A
[80.670696] Dynamic subtest pipe-A: SUCCESS (0.337s)
[80.677748] Starting dynamic subtest: pipe-B
[82.046083] Dynamic subtest pipe-B: SUCCESS (1.374s)
[82.054728] Starting dynamic subtest: pipe-C
[83.474924] Dynamic subtest pipe-C: SUCCESS (1.428s)
[83.485054] Starting dynamic subtest: pipe-D
[84.907071] Dynamic subtest pipe-D: SUCCESS (1.431s)
[84.909309] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.573s)
[86.071071] [017/134] (934s left) gem_ctx_persistence (engines-hang)
[86.141275] Starting subtest: engines-hang
[86.143738] Starting dynamic subtest: rcs0
[86.280029] Dynamic subtest rcs0: SUCCESS (0.141s)
[86.290054] Starting dynamic subtest: bcs0
[86.394405] Dynamic subtest bcs0: SUCCESS (0.113s)
[86.404709] Starting dynamic subtest: vcs0
[86.515547] Dynamic subtest vcs0: SUCCESS (0.120s)
[86.525470] Starting dynamic subtest: vcs1
[86.637767] Dynamic subtest vcs1: SUCCESS (0.122s)
[86.648219] Starting dynamic subtest: vecs0
[86.753748] Dynamic subtest vecs0: SUCCESS (0.115s)
[86.763784] Starting dynamic subtest: ccs0
[86.858068] Dynamic subtest ccs0: SUCCESS (0.103s)
[86.860486] Subtest engines-hang: SUCCESS (0.720s)
[86.944803] [018/134] (934s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[87.038357] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[87.064538] Starting dynamic subtest: pipe-A-plane-0
[87.068307] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[87.074733] Starting dynamic subtest: pipe-A-plane-3
[87.078351] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[87.084731] Starting dynamic subtest: pipe-A-plane-5
[87.088676] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[88.161703] Starting dynamic subtest: pipe-B-plane-0
[88.166243] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[88.175938] Starting dynamic subtest: pipe-B-plane-3
[88.181234] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[88.190155] Starting dynamic subtest: pipe-B-plane-5
[88.194822] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[88.484999] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.443s)
[89.344574] [019/134] (931s left) i915_pm_rc6_residency (media-rc6-accuracy)
[89.404193] Starting subtest: media-rc6-accuracy
[89.408805] Subtest media-rc6-accuracy: SKIP (0.000s)
[89.524570] [020/134] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[89.630522] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[89.634759] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[89.741293] [021/134] (931s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[89.835882] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[89.838108] Starting dynamic subtest: pipe-A-default-mode
[92.579847] Dynamic subtest pipe-A-default-mode: SUCCESS (2.742s)
[92.582170] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.743s)
[93.444874] [022/134] (927s left) kms_chamelium_hpd (vga-hpd-fast)
[93.834725] Subtest vga-hpd-fast: SKIP (0.000s)
[94.653114] [023/134] (926s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[94.719113] Starting subtest: etime-single-wait-all-for-submit-submitted
[94.825837] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[94.908244] [024/134] (926s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[95.003079] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[95.005348] Starting dynamic subtest: pipe-A-eDP-1
[95.014135] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[95.023163] Starting dynamic subtest: pipe-B-eDP-1
[95.031852] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.039331] Starting dynamic subtest: pipe-C-eDP-1
[95.048484] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.055936] Starting dynamic subtest: pipe-D-eDP-1
[95.064787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.068878] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.011s)
[97.357562] [025/134] (923s left) kms_psr (psr-cursor-mmap-cpu)
[97.461618] Starting subtest: psr-cursor-mmap-cpu
[97.464065] Starting dynamic subtest: eDP-1
[99.141376] Dynamic subtest eDP-1: SUCCESS (1.680s)
[99.143731] Subtest psr-cursor-mmap-cpu: SUCCESS (1.680s)
[100.023047] [026/134] (921s left) kms_sequence (get-forked-busy)
[100.115315] Starting subtest: get-forked-busy
[100.117703] Starting dynamic subtest: pipe-A-eDP-1
[102.055268] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[102.064681] Starting dynamic subtest: pipe-B-eDP-1
[104.612260] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.556s)
[104.623209] Starting dynamic subtest: pipe-C-eDP-1
[107.227764] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[107.238744] Starting dynamic subtest: pipe-D-eDP-1
[109.849549] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[109.851771] Subtest get-forked-busy: SUCCESS (9.732s)
[110.667736] [027/134] (910s left) sysfs_timeslice_duration (invalid)
[110.722311] Starting subtest: invalid
[110.724612] Starting dynamic subtest: vecs0
[110.726991] Dynamic subtest vecs0: SUCCESS (0.000s)
[110.735686] Starting dynamic subtest: ccs0
[110.737630] Dynamic subtest ccs0: SUCCESS (0.000s)
[110.744332] Starting dynamic subtest: vcs0
[110.746179] Dynamic subtest vcs0: SUCCESS (0.000s)
[110.753018] Starting dynamic subtest: bcs0
[110.755057] Dynamic subtest bcs0: SUCCESS (0.000s)
[110.763258] Starting dynamic subtest: rcs0
[110.765130] Dynamic subtest rcs0: SUCCESS (0.000s)
[110.771622] Starting dynamic subtest: vcs1
[110.773618] Dynamic subtest vcs1: SUCCESS (0.000s)
[110.775612] Subtest invalid: SUCCESS (0.004s)
[110.849585] [028/134] (910s left) perf (i915-ref-count)
[110.930622] Starting subtest: i915-ref-count
[110.992148] Subtest i915-ref-count: SUCCESS (0.059s)
[111.045807] [029/134] (910s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[111.100445] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[111.102424] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[111.229079] [030/134] (910s left) kms_rmfb (close-fd)
[111.332223] Starting subtest: close-fd
[111.334491] Starting dynamic subtest: pipe-A-eDP-1
[111.439371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[111.448558] Starting dynamic subtest: pipe-B-eDP-1
[112.611263] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.172s)
[112.620046] Starting dynamic subtest: pipe-C-eDP-1
[113.731177] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[113.740179] Starting dynamic subtest: pipe-D-eDP-1
[114.857410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[114.859442] Subtest close-fd: SUCCESS (3.525s)
[116.081292] [031/134] (905s left) template (b)
[116.151000] Starting subtest: B
[116.153273] Subtest B: SUCCESS (0.000s)
[116.266523] [032/134] (905s left) kms_plane (pixel-format-linear-modifier)
[116.363074] Starting subtest: pixel-format-linear-modifier
[116.389889] Starting dynamic subtest: pipe-A-plane-0
[120.067199] Dynamic subtest pipe-A-plane-0: SUCCESS (3.678s)
[120.075060] Starting dynamic subtest: pipe-A-plane-3
[121.734079] Dynamic subtest pipe-A-plane-3: SUCCESS (1.666s)
[121.743812] Starting dynamic subtest: pipe-A-plane-5
[121.934310] Dynamic subtest pipe-A-plane-5: SUCCESS (0.199s)
[123.045502] Starting dynamic subtest: pipe-B-plane-0
[126.523875] Dynamic subtest pipe-B-plane-0: SUCCESS (3.488s)
[126.531371] Starting dynamic subtest: pipe-B-plane-3
[128.168794] Dynamic subtest pipe-B-plane-3: SUCCESS (1.644s)
[128.178750] Starting dynamic subtest: pipe-B-plane-5
[128.379807] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[128.688604] Subtest pixel-format-linear-modifier: SUCCESS (12.326s)
[129.524654] [033/134] (892s left) gem_ctx_shared (q-promotion)
[129.593318] Starting subtest: Q-promotion
[129.595682] Starting dynamic subtest: rcs0
[129.764257] Dynamic subtest rcs0: SUCCESS (0.170s)
[129.779585] Starting dynamic subtest: vcs0
[129.844742] Dynamic subtest vcs0: SUCCESS (0.079s)
[129.860288] Starting dynamic subtest: vcs1
[129.924940] Dynamic subtest vcs1: SUCCESS (0.079s)
[129.939643] Starting dynamic subtest: vecs0
[130.004314] Dynamic subtest vecs0: SUCCESS (0.079s)
[130.019298] Starting dynamic subtest: ccs0
[130.085277] Dynamic subtest ccs0: SUCCESS (0.080s)
[130.087926] Subtest Q-promotion: SUCCESS (0.492s)
[131.042037] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[131.045412] [034/134] (890s left) kms_cursor_crc (cursor-offscreen-max-size)
[131.357688] Starting subtest: cursor-offscreen-max-size
[131.364274] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[131.502732] [035/134] (890s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[131.606375] Starting subtest: fbc-psr-sprite-mmap-gtt
[131.608611] Starting dynamic subtest: eDP-1
[131.613033] Dynamic subtest eDP-1: SKIP (0.000s)
[131.617470] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[131.692564] [036/134] (890s left) sw_sync (sync_merge_invalid)
[131.726364] Starting subtest: sync_merge_invalid
[131.752480] Subtest sync_merge_invalid: SUCCESS (0.025s)
[131.842501] [037/134] (889s left) i915_drm_fdinfo (busy-idle-check-all)
[131.887124] Starting subtest: busy-idle-check-all
[131.889050] Starting dynamic subtest: rcs0
[131.895805] Dynamic subtest rcs0: SKIP (0.009s)
[131.904084] Starting dynamic subtest: bcs0
[131.908175] Dynamic subtest bcs0: SKIP (0.001s)
[131.915483] Starting dynamic subtest: vcs0
[131.919817] Dynamic subtest vcs0: SKIP (0.000s)
[131.927019] Starting dynamic subtest: vcs1
[131.931177] Dynamic subtest vcs1: SKIP (0.000s)
[131.937833] Starting dynamic subtest: vecs0
[131.941965] Dynamic subtest vecs0: SKIP (0.000s)
[131.948767] Starting dynamic subtest: ccs0
[131.952835] Dynamic subtest ccs0: SKIP (0.000s)
[131.956906] Subtest busy-idle-check-all: SKIP (0.015s)
[131.991116] [038/134] (889s left) i915_module_load (reload)
[132.028968] Starting subtest: reload
[135.483615] Subtest reload: SUCCESS (3.456s)
[135.544127] [039/134] (886s left) gem_exec_suspend (basic-s3)
[136.839561] Starting subtest: basic-S3
[136.842009] Starting dynamic subtest: smem
[157.779178] Dynamic subtest smem: SUCCESS (7.110s)
[157.781778] Subtest basic-S3: SUCCESS (7.112s)
[157.968219] [040/134] (863s left) gem_close (many-handles-one-vma)
[158.054559] Starting subtest: many-handles-one-vma
[158.079931] Subtest many-handles-one-vma: SUCCESS (0.026s)
[158.244585] [041/134] (863s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[158.346062] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[158.348350] Starting dynamic subtest: pipe-A-eDP-1
[158.372451] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.383210] Starting dynamic subtest: pipe-B-eDP-1
[158.405720] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.412975] Starting dynamic subtest: pipe-C-eDP-1
[158.435350] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.443018] Starting dynamic subtest: pipe-D-eDP-1
[158.466480] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.470567] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[160.591943] [042/134] (861s left) gem_exec_balancer (parallel-out-fence)
[160.857363] Starting subtest: parallel-out-fence
[162.028487] Subtest parallel-out-fence: SUCCESS (1.197s)
[162.172014] [043/134] (859s left) gem_exec_reloc (basic-gtt-read)
[162.235320] Subtest basic-gtt-read: SKIP (0.000s)
[162.331270] [044/134] (859s left) kms_invalid_mode (bad-vsync-start)
[162.429039] Starting subtest: bad-vsync-start
[162.431342] Starting dynamic subtest: pipe-A-eDP-1
[162.722908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s)
[162.731785] Starting dynamic subtest: pipe-B-eDP-1
[162.734030] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[162.742413] Starting dynamic subtest: pipe-C-eDP-1
[162.744306] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[162.751982] Starting dynamic subtest: pipe-D-eDP-1
[162.754281] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[162.756423] Subtest bad-vsync-start: SUCCESS (0.314s)
[163.570891] [045/134] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[163.676270] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[163.680330] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[163.800618] [046/134] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[163.907712] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[163.911769] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.019834] [047/134] (858s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[164.111228] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[170.616815] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.578s)
[170.778106] [048/134] (851s left) perf_pmu (busy-idle)
[170.819896] Starting subtest: busy-idle
[170.822254] Starting dynamic subtest: rcs0
[171.547236] Dynamic subtest rcs0: SUCCESS (0.734s)
[171.558337] Starting dynamic subtest: bcs0
[172.207438] Dynamic subtest bcs0: SUCCESS (0.662s)
[172.221350] Starting dynamic subtest: vcs0
[173.778085] Dynamic subtest vcs0: SUCCESS (1.574s)
[173.789315] Starting dynamic subtest: vcs1
[175.826959] Dynamic subtest vcs1: SUCCESS (2.055s)
[175.838435] Starting dynamic subtest: vecs0
[177.810238] Dynamic subtest vecs0: SUCCESS (1.987s)
[177.821198] Starting dynamic subtest: ccs0
[178.483935] Dynamic subtest ccs0: SUCCESS (0.675s)
[178.486348] Subtest busy-idle: SUCCESS (7.702s)
[178.615996] [049/134] (843s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[178.745926] Starting subtest: short-flip-after-cursor-toggle
[179.657906] Subtest short-flip-after-cursor-toggle: SUCCESS (0.913s)
[180.508472] [050/134] (841s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[180.613586] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[180.615732] Starting dynamic subtest: pipe-A
[180.633111] Dynamic subtest pipe-A: SKIP (0.017s)
[180.641991] Starting dynamic subtest: pipe-B
[180.667877] Dynamic subtest pipe-B: SKIP (0.034s)
[180.676599] Starting dynamic subtest: pipe-C
[180.701838] Dynamic subtest pipe-C: SKIP (0.033s)
[180.710371] Starting dynamic subtest: pipe-D
[180.730680] Dynamic subtest pipe-D: SKIP (0.029s)
[180.734368] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.115s)
[180.845470] [051/134] (841s left) kms_vblank (ts-continuation-modeset)
[180.935216] Starting subtest: ts-continuation-modeset
[180.937368] Starting dynamic subtest: pipe-A-eDP-1
[182.473753] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.540s)
[182.486343] Starting dynamic subtest: pipe-D-eDP-1
[184.635361] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.162s)
[184.637880] Subtest ts-continuation-modeset: SUCCESS (3.709s)
[185.438152] [052/134] (836s left) gem_exec_fence (keep-in-fence)
[185.616651] Starting subtest: keep-in-fence
[185.619021] Starting dynamic subtest: rcs0
[185.681932] Dynamic subtest rcs0: SUCCESS (0.065s)
[185.693240] Starting dynamic subtest: bcs0
[185.734725] Dynamic subtest bcs0: SUCCESS (0.051s)
[185.745561] Starting dynamic subtest: vcs0
[187.795341] Dynamic subtest vcs0: SUCCESS (2.057s)
[187.806525] Starting dynamic subtest: vcs1
[189.780569] Dynamic subtest vcs1: SUCCESS (1.981s)
[189.790212] Starting dynamic subtest: vecs0
[191.763205] Dynamic subtest vecs0: SUCCESS (1.978s)
[191.774155] Starting dynamic subtest: ccs0
[191.995579] Dynamic subtest ccs0: SUCCESS (0.231s)
[191.998030] Subtest keep-in-fence: SUCCESS (6.377s)
[193.853805] [053/134] (828s left) gem_basic (create-close)
[193.921990] Starting subtest: create-close
[193.926676] Subtest create-close: SUCCESS (0.000s)
[194.041414] [054/134] (828s left) kms_chamelium_color (gamma)
[194.143403] Subtest gamma: SKIP (0.000s)
[194.186929] [055/134] (828s left) perf_pmu (init-sema)
[194.223159] Starting subtest: init-sema
[194.225084] Starting dynamic subtest: rcs0
[194.227413] Dynamic subtest rcs0: SUCCESS (0.002s)
[194.240773] Starting dynamic subtest: bcs0
[194.242777] Dynamic subtest bcs0: SUCCESS (0.000s)
[194.252568] Starting dynamic subtest: vcs0
[194.254479] Dynamic subtest vcs0: SUCCESS (0.001s)
[194.262080] Starting dynamic subtest: vcs1
[194.263942] Dynamic subtest vcs1: SUCCESS (0.000s)
[194.271446] Starting dynamic subtest: vecs0
[194.273324] Dynamic subtest vecs0: SUCCESS (0.001s)
[194.281357] Starting dynamic subtest: ccs0
[194.283560] Dynamic subtest ccs0: SUCCESS (0.001s)
[194.285762] Subtest init-sema: SUCCESS (0.009s)
[194.360057] [056/134] (828s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[194.457966] Starting subtest: fbc-pr-sprite-mmap-cpu
[194.461983] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[194.540796] [057/134] (828s left) kms_lease (lease-get)
[194.632993] Starting subtest: lease-get
[194.635337] Starting dynamic subtest: pipe-A-eDP-1
[194.637629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[194.646894] Starting dynamic subtest: pipe-B-eDP-1
[194.648754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[194.656886] Starting dynamic subtest: pipe-C-eDP-1
[194.658709] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[194.666385] Starting dynamic subtest: pipe-D-eDP-1
[194.668262] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[194.670133] Subtest lease-get: SUCCESS (0.009s)
[194.795521] [058/134] (827s left) gem_lmem_swapping (parallel-random-verify-ccs)
[194.854635] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[194.900810] [059/134] (827s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[194.962664] Starting subtest: y-tiled-ccs-to-x-tiled
[194.966516] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[195.160176] [060/134] (827s left) gem_exec_balancer (bonded-false-hang)
[195.422755] Starting subtest: bonded-false-hang
[195.427400] Subtest bonded-false-hang: SKIP (0.000s)
[195.559500] [061/134] (827s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[200.559540] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[200.564197] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[201.415556] [062/134] (821s left) gen7_exec_parse (basic-allowed)
[201.479511] Subtest basic-allowed: SKIP (0.000s)
[201.565548] [063/134] (821s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[201.670043] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[201.672348] Starting dynamic subtest: pipe-A-eDP-1
[201.692635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[201.703237] Starting dynamic subtest: pipe-B-eDP-1
[201.723749] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[201.731578] Starting dynamic subtest: pipe-C-eDP-1
[201.751027] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[201.758928] Starting dynamic subtest: pipe-D-eDP-1
[201.778164] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[201.780023] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.017s)
[203.869919] [064/134] (819s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[208.853081] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[208.857827] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[209.685618] [065/134] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[209.785280] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[209.789661] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[209.904931] [066/134] (813s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[209.999027] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[210.001209] Starting dynamic subtest: pipe-A-eDP-1
[210.146379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[210.156934] Starting dynamic subtest: pipe-B-eDP-1
[210.175004] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[210.184615] Starting dynamic subtest: pipe-C-eDP-1
[210.204731] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[210.215028] Starting dynamic subtest: pipe-D-eDP-1
[210.234049] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[210.236224] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.175s)
[212.453506] [067/134] (810s left) kms_flip (flip-vs-panning)
[212.555808] Starting subtest: flip-vs-panning
[212.557964] Starting dynamic subtest: A-eDP1
[221.255654] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[221.265730] Starting dynamic subtest: B-eDP1
[229.982316] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[229.995273] Starting dynamic subtest: C-eDP1
[238.692552] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[238.708858] Starting dynamic subtest: D-eDP1
[247.428383] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[247.433162] Subtest flip-vs-panning: SUCCESS (34.886s)
[248.692741] [068/134] (774s left) syncobj_eventfd (timeline-wait)
[248.767151] Starting subtest: timeline-wait
[248.777418] Subtest timeline-wait: SUCCESS (0.010s)
[248.899949] [069/134] (774s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[249.003855] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[249.007856] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[249.171487] [070/134] (774s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[249.275025] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[249.277339] Starting dynamic subtest: A-eDP1
[252.905099] Dynamic subtest A-eDP1: SUCCESS (3.626s)
[252.914565] Starting dynamic subtest: B-eDP1
[256.096520] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[256.106860] Starting dynamic subtest: C-eDP1
[259.187774] Dynamic subtest C-eDP1: SUCCESS (3.088s)
[259.196972] Starting dynamic subtest: D-eDP1
[262.297765] Dynamic subtest D-eDP1: SUCCESS (3.109s)
[262.300056] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.021s)
[263.112536] [071/134] (760s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[263.213852] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[264.191294] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.979s)
[264.351799] [072/134] (758s left) gem_mmap_offset (oob-read)
[264.416355] Starting subtest: oob-read
[264.418772] Subtest oob-read: SUCCESS (0.001s)
[264.551855] [073/134] (758s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[264.648300] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[264.650150] Starting dynamic subtest: pipe-A-default-mode
[264.983049] Dynamic subtest pipe-A-default-mode: SKIP (0.333s)
[264.987585] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.334s)
[265.831877] [074/134] (757s left) gem_pxp (regular-baseline-src-copy-readible)
[265.956879] Starting subtest: regular-baseline-src-copy-readible
[266.023735] Subtest regular-baseline-src-copy-readible: SUCCESS (0.068s)
[266.174037] [075/134] (757s left) kms_3d (basic)
[266.237125] Starting subtest: basic
[268.237285] Subtest basic: SUCCESS (2.000s)
[268.767332] [076/134] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[268.872281] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[268.876278] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[269.008489] [077/134] (754s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[269.107133] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[269.111438] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[269.237169] [078/134] (754s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[269.344274] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[269.348202] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[269.452423] [079/134] (754s left) gem_exec_schedule (fairslice-all)
[269.526811] Starting subtest: fairslice-all
[271.572633] Subtest fairslice-all: SUCCESS (2.051s)
[272.887418] [080/134] (750s left) kms_properties (plane-properties-atomic)
[272.999822] Starting subtest: plane-properties-atomic
[273.002046] Starting dynamic subtest: pipe-A-eDP-1
[273.570719] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[273.580274] Starting dynamic subtest: pipe-B-eDP-1
[274.910643] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s)
[274.920479] Starting dynamic subtest: pipe-C-eDP-1
[276.194496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s)
[276.204983] Starting dynamic subtest: pipe-D-eDP-1
[277.489498] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[277.491881] Subtest plane-properties-atomic: SUCCESS (4.491s)
[278.358350] [081/134] (745s left) gem_cs_tlb (engines)
[278.414403] Starting subtest: engines
[278.416776] Starting dynamic subtest: rcs0
[280.571256] Dynamic subtest rcs0: SUCCESS (2.151s)
[280.583075] Starting dynamic subtest: bcs0
[282.723110] Dynamic subtest bcs0: SUCCESS (2.151s)
[282.732177] Starting dynamic subtest: vcs0
[284.876455] Dynamic subtest vcs0: SUCCESS (2.152s)
[284.887675] Starting dynamic subtest: vcs1
[287.030072] Dynamic subtest vcs1: SUCCESS (2.152s)
[287.042104] Starting dynamic subtest: vecs0
[289.182808] Dynamic subtest vecs0: SUCCESS (2.152s)
[289.196665] Starting dynamic subtest: ccs0
[291.336426] Dynamic subtest ccs0: SUCCESS (2.153s)
[291.338557] Subtest engines: SUCCESS (12.918s)
[291.508802] [082/134] (732s left) kms_scaling_modes (scaling-mode-none)
[291.604455] Starting subtest: scaling-mode-none
[291.606309] Starting dynamic subtest: pipe-A-eDP-1
[291.702066] Dynamic subtest pipe-A-eDP-1: SKIP (0.096s)
[291.711957] Starting dynamic subtest: pipe-B-eDP-1
[291.735603] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[291.744538] Starting dynamic subtest: pipe-C-eDP-1
[291.768332] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[291.777401] Starting dynamic subtest: pipe-D-eDP-1
[291.801262] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[291.805280] Subtest scaling-mode-none: SKIP (0.197s)
[291.938121] [083/134] (731s left) kms_psr (pr-sprite-render)
[292.034559] Starting subtest: pr-sprite-render
[292.038928] Subtest pr-sprite-render: SKIP (0.000s)
[292.119285] [084/134] (731s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[292.226437] Starting subtest: fbc-abgr161616f-draw-pwrite
[292.230853] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[292.368823] [085/134] (731s left) kms_flip (2x-flip-vs-expired-vblank)
[292.474369] Starting subtest: 2x-flip-vs-expired-vblank
[292.485400] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[292.627039] [086/134] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[292.727424] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[292.730859] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[292.845776] [087/134] (731s left) kms_content_protection (srm)
[292.983267] Starting subtest: srm
[292.989285] Subtest srm: SKIP (0.002s)
[293.145592] [088/134] (730s left) gem_userptr_blits (process-exit-busy)
[293.210243] Starting subtest: process-exit-busy
[293.224990] Subtest process-exit-busy: SUCCESS (0.015s)
[293.379202] [089/134] (730s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[293.477264] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[293.480960] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[293.602194] [090/134] (730s left) kms_color (invalid-degamma-lut-sizes)
[293.697105] Starting subtest: invalid-degamma-lut-sizes
[293.699010] Starting dynamic subtest: pipe-A
[294.002983] Dynamic subtest pipe-A: SUCCESS (0.307s)
[294.012348] Starting dynamic subtest: pipe-B
[294.014617] Dynamic subtest pipe-B: SUCCESS (0.000s)
[294.023405] Starting dynamic subtest: pipe-C
[294.025898] Dynamic subtest pipe-C: SUCCESS (0.000s)
[294.034761] Starting dynamic subtest: pipe-D
[294.037035] Dynamic subtest pipe-D: SUCCESS (0.000s)
[294.039174] Subtest invalid-degamma-lut-sizes: SUCCESS (0.310s)
[294.870821] [091/134] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[294.978313] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[294.982511] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[295.109223] [092/134] (728s left) kms_pipe_crc_basic (nonblocking-crc)
[295.200672] Starting subtest: nonblocking-crc
[295.202931] Starting dynamic subtest: pipe-A-eDP-1
[295.935618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[295.946019] Starting dynamic subtest: pipe-B-eDP-1
[297.333917] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[297.352594] Starting dynamic subtest: pipe-C-eDP-1
[298.678646] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s)
[298.688409] Starting dynamic subtest: pipe-D-eDP-1
[300.065357] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.383s)
[300.067312] Subtest nonblocking-crc: SUCCESS (4.865s)
[300.954396] [093/134] (723s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[301.058810] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[301.816253] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.759s)
[302.011597] [094/134] (722s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[302.118035] Starting subtest: 4-tiled-8bpp-rotate-0
[303.297990] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.180s)
[303.468648] [095/134] (720s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[303.566341] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[303.569878] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[303.704858] [096/134] (720s left) gem_exec_schedule (u-semaphore-codependency)
[303.772501] Starting subtest: u-semaphore-codependency
[303.781341] Subtest u-semaphore-codependency: SUCCESS (0.015s)
[304.164998] [097/134] (720s left) syncobj_timeline (wait-any-snapshot)
[304.227368] Starting subtest: wait-any-snapshot
[304.308308] Subtest wait-any-snapshot: SUCCESS (0.081s)
[304.412753] [098/134] (719s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[304.485565] Subtest no-spare-fences-busy: SKIP (0.000s)
[304.551935] [099/134] (719s left) kms_dsc (dsc-with-output-formats-with-bpc)
[304.652394] Starting subtest: dsc-with-output-formats-with-bpc
[304.707612] Subtest dsc-with-output-formats-with-bpc: SKIP (0.003s)
[304.755724] [100/134] (719s left) gem_userptr_blits (dmabuf-unsync)
[304.832253] Subtest dmabuf-unsync: SKIP (0.000s)
[304.987043] [101/134] (719s left) kms_prop_blob (blob-prop-core)
[305.047144] Starting subtest: blob-prop-core
[305.048755] Subtest blob-prop-core: SUCCESS (0.000s)
[305.154423] [102/134] (719s left) gem_exec_reloc (basic-gtt-cpu)
[305.215998] Subtest basic-gtt-cpu: SKIP (0.000s)
[305.300947] [103/134] (719s left) syncobj_timeline (invalid-query-bad-pad)
[305.361015] Starting subtest: invalid-query-bad-pad
[305.362818] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[305.501668] [104/134] (719s left) vgem_basic (dmabuf-export)
[305.547709] Starting subtest: dmabuf-export
[305.600592] Subtest dmabuf-export: SUCCESS (0.054s)
[305.729046] [105/134] (718s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[305.831782] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[305.835213] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[305.936896] [106/134] (718s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[306.041807] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[306.045077] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[306.181002] [107/134] (718s left) gem_gpgpu_fill (basic)
[306.237517] Starting subtest: basic
[306.239464] Starting dynamic subtest: smem
[306.243573] Dynamic subtest smem: SUCCESS (0.008s)
[306.245340] Subtest basic: SUCCESS (0.009s)
[306.407600] [108/134] (718s left) gem_mmap_gtt (basic-copy)
[306.471200] Subtest basic-copy: SKIP (0.000s)
[306.548123] [109/134] (718s left) gen9_exec_parse (batch-invalid-length)
[306.611351] Subtest batch-invalid-length: SKIP (0.000s)
[306.695317] [110/134] (718s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[306.799987] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[306.803640] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[306.920412] [111/134] (717s left) gem_tiled_wc
[307.062078] [112/134] (717s left) gem_exec_capture (userptr)
[307.126026] Starting subtest: userptr
[307.968952] Subtest userptr: SUCCESS (0.841s)
[308.135185] [113/134] (716s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[308.225881] Starting subtest: flip-vs-dpms-off-vs-modeset
[308.228050] Starting dynamic subtest: A-eDP1
[311.865732] Dynamic subtest A-eDP1: SUCCESS (3.637s)
[311.875628] Starting dynamic subtest: B-eDP1
[315.187396] Dynamic subtest B-eDP1: SUCCESS (3.320s)
[315.197425] Starting dynamic subtest: C-eDP1
[318.478626] Dynamic subtest C-eDP1: SUCCESS (3.294s)
[318.488586] Starting dynamic subtest: D-eDP1
[321.783112] Dynamic subtest D-eDP1: SUCCESS (3.303s)
[321.785373] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.561s)
[322.648551] [114/134] (702s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[322.759131] Starting subtest: fbc-rgb565-draw-pwrite
[327.344626] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.590s)
[328.568472] [115/134] (696s left) gem_exec_whisper (basic-contexts-forked-all)
[328.632417] Starting subtest: basic-contexts-forked-all
[348.756540] Subtest basic-contexts-forked-all: SUCCESS (20.123s)
[348.950332] [116/134] (676s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[349.091841] Starting subtest: cursorB-vs-flipB-atomic
[349.096432] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[349.249938] [117/134] (675s left) gem_pread (exhaustion)
[349.309936] Subtest exhaustion: SKIP (0.000s)
[349.366379] [118/134] (675s left) gem_ctx_persistence (heartbeat-hostile)
[349.422759] Starting subtest: heartbeat-hostile
[349.427190] Subtest heartbeat-hostile: SKIP (0.000s)
[349.542842] [119/134] (675s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[349.636108] Starting subtest: extended-pageflip-modeset-hang-oldfb
[349.638368] Starting dynamic subtest: pipe-A
[357.527740] Dynamic subtest pipe-A: SUCCESS (7.894s)
[357.539527] Starting dynamic subtest: pipe-D
[366.112744] Dynamic subtest pipe-D: SUCCESS (8.584s)
[366.116204] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.483s)
[366.929793] [120/134] (658s left) gem_sync (basic-store-each)
[367.016346] Starting subtest: basic-store-each
[369.433711] Subtest basic-store-each: SUCCESS (2.429s)
[369.632576] [121/134] (655s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[369.738976] Starting subtest: psr-shrfb-scaledprimary
[375.408094] Subtest psr-shrfb-scaledprimary: SUCCESS (5.671s)
[375.551764] [122/134] (649s left) dmabuf_sync_file (import-multiple-read-only)
[375.595854] Starting subtest: import-multiple-read-only
[375.598140] Subtest import-multiple-read-only: SUCCESS (0.003s)
[375.664116] [123/134] (649s left) kms_atomic_interruptible (universal-setplane-primary)
[375.765575] Starting subtest: universal-setplane-primary
[375.767951] Starting dynamic subtest: pipe-A-eDP-1
[383.222909] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.454s)
[383.225188] Subtest universal-setplane-primary: SUCCESS (7.455s)
[384.063522] [124/134] (641s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[384.161186] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[390.790248] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.628s)
[390.963046] [125/134] (634s left) kms_cursor_edge_walk (128x128-right-edge)
[391.059824] Starting subtest: 128x128-right-edge
[391.062244] Starting dynamic subtest: pipe-A-eDP-1
[394.566404] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[394.577032] Starting dynamic subtest: pipe-D-eDP-1
[397.743233] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.174s)
[397.745532] Subtest 128x128-right-edge: SUCCESS (6.680s)
[398.545939] [126/134] (626s left) api_intel_allocator (two-level-inception)
[398.607680] Starting subtest: two-level-inception
[404.004325] Subtest two-level-inception: SUCCESS (5.397s)
[404.137508] [127/134] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[404.255206] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[404.259317] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[404.386877] [128/134] (621s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[404.456502] Starting subtest: wait-all-for-submit-delayed-submit
[404.557369] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[404.652719] [129/134] (620s left) gem_exec_schedule (pi-ringfull)
[404.842272] Starting subtest: pi-ringfull
[404.844802] Starting dynamic subtest: rcs0
[404.888807] Dynamic subtest rcs0: SUCCESS (0.050s)
[404.899559] Starting dynamic subtest: bcs0
[404.940766] Dynamic subtest bcs0: SUCCESS (0.051s)
[404.951283] Starting dynamic subtest: vcs0
[404.984086] Dynamic subtest vcs0: SUCCESS (0.042s)
[404.993945] Starting dynamic subtest: vcs1
[405.025977] Dynamic subtest vcs1: SUCCESS (0.040s)
[405.040185] Starting dynamic subtest: vecs0
[405.060091] Dynamic subtest vecs0: SUCCESS (0.033s)
[405.073220] Starting dynamic subtest: ccs0
[405.089453] Dynamic subtest ccs0: SUCCESS (0.029s)
[405.091668] Subtest pi-ringfull: SUCCESS (0.252s)
[405.362913] [130/134] (620s left) kms_async_flips (crc-atomic)
[405.480969] Starting subtest: crc-atomic
[405.865197] Starting dynamic subtest: pipe-A-eDP-1
[408.817673] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.949s)
[409.200474] Starting dynamic subtest: pipe-B-eDP-1
[412.120817] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.930s)
[412.494629] Starting dynamic subtest: pipe-C-eDP-1
[415.383382] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.898s)
[415.769667] Starting dynamic subtest: pipe-D-eDP-1
[418.715772] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.954s)
[418.718135] Subtest crc-atomic: SUCCESS (13.233s)
[419.953164] [131/134] (605s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[425.021161] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[425.023497] Starting dynamic subtest: pipe-A-eDP-1
[431.505206] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.484s)
[431.515420] Starting dynamic subtest: pipe-B-eDP-1
[437.981967] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.473s)
[437.984403] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.960s)
[438.839000] [132/134] (586s left) i915_suspend (fence-restore-tiled2untiled)
[438.892033] Starting subtest: fence-restore-tiled2untiled
[438.896132] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[439.000369] [133/134] (586s left) prime_busy (after)
[439.067435] Starting subtest: after
[439.072225] Starting dynamic subtest: rcs0
[439.128479] Dynamic subtest rcs0: SUCCESS (0.058s)
[439.138867] Starting dynamic subtest: bcs0
[439.206368] Dynamic subtest bcs0: SUCCESS (0.077s)
[439.216955] Starting dynamic subtest: vcs0
[439.246755] Dynamic subtest vcs0: SUCCESS (0.040s)
[439.255769] Starting dynamic subtest: vcs1
[439.287169] Dynamic subtest vcs1: SUCCESS (0.039s)
[439.296165] Starting dynamic subtest: vecs0
[439.327109] Dynamic subtest vecs0: SUCCESS (0.039s)
[439.335970] Starting dynamic subtest: ccs0
[439.368784] Dynamic subtest ccs0: SUCCESS (0.041s)
[439.476873] Subtest after: SUCCESS (0.408s)
[439.565679] [134/134] (586s left) prime_mmap (test_refcounting)
[439.614941] Starting subtest: test_refcounting
[439.617201] Starting dynamic subtest: test_refcounting-smem
[439.659108] Dynamic subtest test_refcounting-smem: SUCCESS (0.046s)
[439.661599] Subtest test_refcounting: SUCCESS (0.047s)
[439.780566] Closing watchdogs
results: parsing output: 0/ for test: dumb_buffer
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_dp_linktrain_fallback
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_partial_pwrite_pread
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: i915_pm_rc6_residency
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_sequence
results: parsing output: 26/ for test: sysfs_timeslice_duration
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_rmfb
results: parsing output: 30/ for test: template
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_ctx_shared
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: i915_module_load
results: parsing output: 38/ for test: gem_exec_suspend
results: parsing output: 39/ for test: gem_close
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_invalid_mode
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_basic
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: syncobj_eventfd
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: kms_3d
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: gem_cs_tlb
results: parsing output: 81/ for test: kms_scaling_modes
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_dsc
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_gpgpu_fill
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_tiled_wc
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_pread
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: gem_sync
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: dmabuf_sync_file
results: parsing output: 122/ for test: kms_atomic_interruptible
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_edge_walk
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: i915_suspend
results: parsing output: 132/ for test: prime_busy
results: parsing output: 133/ for test: prime_mmap
Done.