[58.170365] Initializing watchdogs
[58.170414]   /dev/watchdog0
[58.186087] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.190096] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.192122] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.196152] [001/132] (960s left) kms_cursor_crc (cursor-offscreen-64x64)
[58.402910] Starting subtest: cursor-offscreen-64x64
[58.418171] Starting dynamic subtest: pipe-A-eDP-1
[60.417646] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.001s)
[60.451114] Starting dynamic subtest: pipe-D-eDP-1
[62.996608] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[62.999028] Subtest cursor-offscreen-64x64: SUCCESS (4.594s)
[63.872034] [002/132] (954s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[63.924504] Starting subtest: single-wait-all-for-submit-unsubmitted
[64.029871] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[64.098796] [003/132] (954s left) kms_prop_blob (invalid-set-prop-any)
[64.146859] Starting subtest: invalid-set-prop-any
[64.148850] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[64.250487] [004/132] (954s left) syncobj_wait (invalid-reset-bad-pad)
[64.322086] Starting subtest: invalid-reset-bad-pad
[64.324450] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[64.432248] [005/132] (954s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[64.522263] Starting subtest: psr-modesetfrombusy
[70.722310] Subtest psr-modesetfrombusy: SUCCESS (6.205s)
[70.859178] [006/132] (948s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[70.940222] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[70.942100] Starting dynamic subtest: pipe-A-eDP-1
[70.960294] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.967737] Starting dynamic subtest: pipe-B-eDP-1
[70.984480] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.993407] Starting dynamic subtest: pipe-C-eDP-1
[71.011167] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[71.017818] Starting dynamic subtest: pipe-D-eDP-1
[71.036066] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[71.039715] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[73.097452] [007/132] (945s left) kms_psr (psr-sprite-blt)
[73.175797] Starting subtest: psr-sprite-blt
[73.178601] Starting dynamic subtest: eDP-1
[74.918534] Dynamic subtest eDP-1: SUCCESS (1.743s)
[74.920882] Subtest psr-sprite-blt: SUCCESS (1.743s)
[75.761904] [008/132] (943s left) prime_self_import (basic-with_two_bos)
[75.798225] Starting subtest: basic-with_two_bos
[75.821259] Subtest basic-with_two_bos: SUCCESS (0.025s)
[75.922680] [009/132] (943s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[76.007071] Starting subtest: x-tiled-64bpp-rotate-90
[76.028973] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[76.139729] [010/132] (942s left) kms_psr (pr-primary-mmap-cpu)
[76.209592] Starting subtest: pr-primary-mmap-cpu
[76.213940] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[76.284029] [011/132] (942s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[76.357160] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[76.365923] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.007s)
[76.437901] [012/132] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[76.506333] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[83.794325] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.289s)
[83.902977] [013/132] (935s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[83.951750] Starting subtest: etime-multi-wait-all-for-submit-submitted
[84.053633] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[84.124058] [014/132] (935s left) gem_spin_batch (resubmit-all)
[84.184457] Starting subtest: resubmit-all
[84.186782] Starting dynamic subtest: rcs0
[84.195991] Dynamic subtest rcs0: SUCCESS (0.011s)
[84.204994] Starting dynamic subtest: bcs0
[84.207550] Dynamic subtest bcs0: SUCCESS (0.003s)
[84.216066] Starting dynamic subtest: vcs0
[84.217936] Dynamic subtest vcs0: SUCCESS (0.005s)
[84.224783] Starting dynamic subtest: vcs1
[84.226688] Dynamic subtest vcs1: SUCCESS (0.002s)
[84.233539] Starting dynamic subtest: vecs0
[84.235467] Dynamic subtest vecs0: SUCCESS (0.002s)
[84.242231] Starting dynamic subtest: ccs0
[84.244093] Dynamic subtest ccs0: SUCCESS (0.002s)
[84.245984] Subtest resubmit-all: SUCCESS (0.027s)
[85.885034] [015/132] (933s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[85.942804] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[86.046424] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[86.118265] [016/132] (933s left) kms_pm_rpm (system-suspend-idle)
[88.021389] Starting subtest: system-suspend-idle
[107.845416] Subtest system-suspend-idle: SUCCESS (4.475s)
[108.206773] [017/132] (911s left) perf_pmu (interrupts)
[108.259836] Starting subtest: interrupts
[109.379566] Subtest interrupts: SUCCESS (1.119s)
[109.496431] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[109.499813] [018/132] (909s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[109.582764] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[109.584768] Starting dynamic subtest: pipe-A-eDP-1
[110.130204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.517s)
[110.140053] Starting dynamic subtest: pipe-B-eDP-1
[111.572355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[111.583487] Starting dynamic subtest: pipe-C-eDP-1
[112.955245] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[112.966034] Starting dynamic subtest: pipe-D-eDP-1
[114.384965] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.431s)
[114.387261] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.775s)
[115.522128] [019/132] (903s left) kms_content_protection (dp-mst-lic-type-1)
[115.672958] Starting subtest: dp-mst-lic-type-1
[115.677397] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[115.783119] [020/132] (903s left) kms_color_pipeline (plane-ctm3x4)
[115.860121] Starting subtest: plane-ctm3x4
[115.986434] Starting dynamic subtest: pipe-A-plane-0
[116.118107] Dynamic subtest pipe-A-plane-0: SUCCESS (0.133s)
[116.130766] Starting dynamic subtest: pipe-A-plane-1
[116.228861] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s)
[116.238319] Starting dynamic subtest: pipe-A-plane-2
[116.340136] Dynamic subtest pipe-A-plane-2: SUCCESS (0.111s)
[117.552054] Starting dynamic subtest: pipe-B-plane-0
[117.712346] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[117.722506] Starting dynamic subtest: pipe-B-plane-1
[117.822858] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[117.832198] Starting dynamic subtest: pipe-B-plane-2
[117.978474] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[119.153460] Starting dynamic subtest: pipe-C-plane-0
[119.256735] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[119.266302] Starting dynamic subtest: pipe-C-plane-1
[119.367911] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s)
[119.377356] Starting dynamic subtest: pipe-C-plane-2
[119.479134] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s)
[120.675043] Starting dynamic subtest: pipe-D-plane-0
[120.778695] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[120.788577] Starting dynamic subtest: pipe-D-plane-1
[120.934495] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[120.949572] Starting dynamic subtest: pipe-D-plane-2
[121.045377] Dynamic subtest pipe-D-plane-2: SUCCESS (0.111s)
[121.335325] Subtest plane-ctm3x4: SUCCESS (5.473s)
[122.149815] [021/132] (897s left) syncobj_timeline (invalid-transfer-non-existent-point)
[122.211033] Starting subtest: invalid-transfer-non-existent-point
[122.213055] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[122.297372] [022/132] (897s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[122.398211] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[122.402830] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[122.553975] [023/132] (896s left) gem_mmap_gtt (medium-copy-odd)
[122.625158] Subtest medium-copy-odd: SKIP (0.000s)
[122.693022] [024/132] (896s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[122.750948] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[122.822867] [025/132] (896s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[122.904462] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[122.908612] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[122.999704] [026/132] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[123.090611] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[123.094101] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[123.199119] [027/132] (896s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[123.270845] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[123.272790] Starting dynamic subtest: pipe-A-eDP-1
[123.290849] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.300251] Starting dynamic subtest: pipe-B-eDP-1
[123.317537] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.325319] Starting dynamic subtest: pipe-C-eDP-1
[123.342046] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.349816] Starting dynamic subtest: pipe-D-eDP-1
[123.367612] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.370911] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[125.419356] [028/132] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[125.497417] Starting subtest: compare-crc-sanitycheck-nv12
[125.499640] Starting dynamic subtest: pipe-A-eDP-1
[126.169945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[126.179767] Starting dynamic subtest: pipe-B-eDP-1
[127.449589] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.278s)
[127.458067] Starting dynamic subtest: pipe-C-eDP-1
[128.719602] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.266s)
[128.729356] Starting dynamic subtest: pipe-D-eDP-1
[129.933092] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[129.935385] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.437s)
[130.776744] [029/132] (888s left) gem_exec_whisper (basic-queues)
[130.855050] Starting subtest: basic-queues
[136.176662] Subtest basic-queues: SUCCESS (5.318s)
[136.357933] [030/132] (883s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[136.444926] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[136.447322] Starting dynamic subtest: pipe-A-eDP-1
[136.467538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[136.478464] Starting dynamic subtest: pipe-B-eDP-1
[136.497030] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[136.505645] Starting dynamic subtest: pipe-C-eDP-1
[136.525100] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[136.533496] Starting dynamic subtest: pipe-D-eDP-1
[136.552545] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[136.554735] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.009s)
[138.734388] [031/132] (881s left) gem_ctx_param (invalid-param-set)
[138.784978] Starting subtest: invalid-param-set
[138.787283] Subtest invalid-param-set: SUCCESS (0.000s)
[138.875658] [032/132] (881s left) gem_render_copy (y-tiled-ccs-to-linear)
[138.941565] Starting subtest: y-tiled-ccs-to-linear
[138.946105] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[139.128423] [033/132] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[139.212167] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[146.691496] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.485s)
[146.856307] [034/132] (873s left) prime_busy (hang-wait)
[146.926754] Starting subtest: hang-wait
[146.929203] Starting dynamic subtest: rcs0
[172.661950] Dynamic subtest rcs0: SUCCESS (25.731s)
[172.672740] Starting dynamic subtest: bcs0
[179.848816] Dynamic subtest bcs0: SUCCESS (7.183s)
[179.857508] Starting dynamic subtest: vcs0
[186.907984] Dynamic subtest vcs0: SUCCESS (7.056s)
[186.918578] Starting dynamic subtest: vcs1
[193.931554] Dynamic subtest vcs1: SUCCESS (7.022s)
[193.943027] Starting dynamic subtest: vecs0
[200.863444] Dynamic subtest vecs0: SUCCESS (6.930s)
[200.873735] Starting dynamic subtest: ccs0
[214.636706] Dynamic subtest ccs0: SUCCESS (13.775s)
[214.639550] Subtest hang-wait: SUCCESS (67.708s)
[214.755874] [035/132] (805s left) gem_tiled_partial_pwrite_pread (writes)
[214.806972] Subtest writes: SKIP (0.000s)
[214.879391] [036/132] (805s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[214.936766] Starting subtest: yf-tiled-to-vebox-yf-tiled
[214.941252] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[215.140298] [037/132] (804s left) sysfs_timeslice_duration (invalid)
[215.198946] Starting subtest: invalid
[215.201386] Starting dynamic subtest: vecs0
[215.203776] Dynamic subtest vecs0: SUCCESS (0.000s)
[215.214798] Starting dynamic subtest: ccs0
[215.216738] Dynamic subtest ccs0: SUCCESS (0.000s)
[215.225822] Starting dynamic subtest: vcs0
[215.228137] Dynamic subtest vcs0: SUCCESS (0.000s)
[215.237115] Starting dynamic subtest: bcs0
[215.239078] Dynamic subtest bcs0: SUCCESS (0.000s)
[215.247746] Starting dynamic subtest: rcs0
[215.249718] Dynamic subtest rcs0: SUCCESS (0.000s)
[215.258360] Starting dynamic subtest: vcs1
[215.260345] Dynamic subtest vcs1: SUCCESS (0.000s)
[215.262334] Subtest invalid: SUCCESS (0.005s)
[215.303094] [038/132] (804s left) gem_exec_gttfill (multigpu-basic)
[215.480960] Starting subtest: multigpu-basic
[227.329183] Subtest multigpu-basic: SUCCESS (11.848s)
[227.418618] [039/132] (792s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[227.515942] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[227.572840] [040/132] (792s left) kms_chamelium_edid (dp-edid-read)
[227.948046] Subtest dp-edid-read: SKIP (0.000s)
[228.754429] [041/132] (791s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[228.837626] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[228.842101] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[228.942697] [042/132] (791s left) gem_ctx_persistence (file)
[229.009022] Starting subtest: file
[229.128174] Subtest file: SUCCESS (0.119s)
[229.258371] [043/132] (791s left) sw_sync (sync_multi_timeline_wait)
[229.300841] Starting subtest: sync_multi_timeline_wait
[229.303477] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[229.357073] [044/132] (791s left) gem_exec_nop (basic-parallel)
[229.430635] Starting subtest: basic-parallel
[244.177673] Subtest basic-parallel: SUCCESS (14.755s)
[244.407029] [045/132] (776s left) api_intel_allocator (reloc-allocator)
[244.465935] Starting subtest: reloc-allocator
[244.468153] Starting dynamic subtest: basic
[244.470941] Dynamic subtest basic: SUCCESS (0.006s)
[244.481469] Starting dynamic subtest: parallel-one
[244.483800] Dynamic subtest parallel-one: SUCCESS (0.007s)
[244.492811] Starting dynamic subtest: print
[244.495201] Dynamic subtest print: SUCCESS (0.000s)
[244.504000] Starting dynamic subtest: reuse
[244.506124] Dynamic subtest reuse: SUCCESS (0.000s)
[244.514401] Starting dynamic subtest: fork-reopen-allocator
[244.516283] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[244.518191] Subtest reloc-allocator: SUCCESS (0.028s)
[244.624769] [046/132] (775s left) gem_exec_schedule (u-semaphore-resolve)
[244.695506] Starting subtest: u-semaphore-resolve
[244.747199] Subtest u-semaphore-resolve: SUCCESS (0.062s)
[245.110003] [047/132] (775s left) gem_mmap_gtt (cpuset-basic-small-copy)
[245.174236] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[245.233196] [048/132] (775s left) kms_addfb_basic (too-high)
[245.306073] Starting subtest: too-high
[245.308335] Subtest too-high: SUCCESS (0.000s)
[245.395855] [049/132] (775s left) gem_eio (in-flight-internal-10ms)
[245.624556] Starting subtest: in-flight-internal-10ms
[247.260181] Subtest in-flight-internal-10ms: SUCCESS (1.635s)
[247.393053] [050/132] (773s left) kms_psr (psr2-cursor-mmap-cpu)
[247.471899] Starting subtest: psr2-cursor-mmap-cpu
[247.474174] Starting dynamic subtest: eDP-1
[249.162651] Dynamic subtest eDP-1: SUCCESS (1.688s)
[249.164628] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.689s)
[249.966688] [051/132] (770s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[250.050263] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[250.052597] Starting dynamic subtest: pipe-A-eDP-1
[255.924081] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.876s)
[255.934518] Starting dynamic subtest: pipe-B-eDP-1
[262.589694] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.665s)
[262.592062] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.544s)
[263.463693] [052/132] (757s left) syncobj_timeline (multi-wait-signaled)
[263.531189] Starting subtest: multi-wait-signaled
[263.533051] Subtest multi-wait-signaled: SUCCESS (0.001s)
[263.632759] [053/132] (757s left) kms_atomic (plane-immutable-zpos)
[263.712133] Starting subtest: plane-immutable-zpos
[263.714390] Starting dynamic subtest: pipe-A-eDP-1
[264.384838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.670s)
[264.387400] Subtest plane-immutable-zpos: SUCCESS (0.672s)
[265.190851] [054/132] (755s left) kms_feature_discovery (display-4x)
[265.266940] Starting subtest: display-4x
[265.271437] Subtest display-4x: SKIP (0.000s)
[265.353369] [055/132] (755s left) gen7_exec_parse (chained-batch)
[265.409434] Subtest chained-batch: SKIP (0.000s)
[265.480939] [056/132] (755s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[265.555600] Starting subtest: bad-aux-stride-y-tiled-ccs
[265.558033] Starting dynamic subtest: pipe-A-eDP-1
[265.581058] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.593345] Starting dynamic subtest: pipe-B-eDP-1
[265.615512] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.624721] Starting dynamic subtest: pipe-C-eDP-1
[265.646545] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.655669] Starting dynamic subtest: pipe-D-eDP-1
[265.677495] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.681631] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[267.767840] [057/132] (753s left) gem_ctx_param (invalid-param-get)
[267.821782] Starting subtest: invalid-param-get
[267.824129] Subtest invalid-param-get: SUCCESS (0.001s)
[267.919957] [058/132] (753s left) gem_ctx_freq (sysfs)
[267.992274] Starting subtest: sysfs
[267.994646] Starting dynamic subtest: gt0
[273.530551] Dynamic subtest gt0: SUCCESS (5.537s)
[273.542896] Starting dynamic subtest: gt1
[315.216313] Dynamic subtest gt1: SUCCESS (41.682s)
[315.219193] Subtest sysfs: SUCCESS (47.222s)
[315.327800] [059/132] (705s left) gem_partial_pwrite_pread (write-uncached)
[315.386042] Subtest write-uncached: SKIP (0.000s)
[315.457845] [060/132] (705s left) gem_exec_fence (submit-chain)
[315.629313] Starting subtest: submit-chain
[315.660533] Subtest submit-chain: SUCCESS (0.032s)
[317.307284] [061/132] (703s left) perf_pmu (busy-start)
[317.346640] Starting subtest: busy-start
[317.348754] Starting dynamic subtest: rcs0
[319.900425] Dynamic subtest rcs0: SUCCESS (2.554s)
[319.912849] Starting dynamic subtest: bcs0
[322.449841] Dynamic subtest bcs0: SUCCESS (2.547s)
[322.462294] Starting dynamic subtest: vcs0
[326.224612] Dynamic subtest vcs0: SUCCESS (3.771s)
[326.237440] Starting dynamic subtest: vcs1
[330.192785] Dynamic subtest vcs1: SUCCESS (3.965s)
[330.206198] Starting dynamic subtest: vecs0
[334.224568] Dynamic subtest vecs0: SUCCESS (4.029s)
[334.238145] Starting dynamic subtest: ccs0
[336.776955] Dynamic subtest ccs0: SUCCESS (2.551s)
[336.779978] Subtest busy-start: SUCCESS (19.432s)
[336.877405] [062/132] (684s left) i915_pm_rps (basic-api)
[336.949400] Starting subtest: basic-api
[336.953876] Subtest basic-api: SKIP (0.001s)
[337.059276] [063/132] (684s left) kms_vblank (wait-forked)
[337.149571] Starting subtest: wait-forked
[337.151789] Starting dynamic subtest: pipe-A-eDP-1
[338.966718] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.814s)
[338.982945] Starting dynamic subtest: pipe-D-eDP-1
[341.453282] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.486s)
[341.455661] Subtest wait-forked: SUCCESS (4.303s)
[342.355044] [064/132] (678s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[342.441078] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[342.443360] Starting dynamic subtest: pipe-A-default-mode
[343.557083] Dynamic subtest pipe-A-default-mode: SKIP (1.112s)
[343.561655] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.114s)
[343.744526] [065/132] (677s left) testdisplay
[344.018360] [066/132] (677s left) kms_psr (fbc-psr2-suspend)
[344.090052] Starting subtest: fbc-psr2-suspend
[344.092278] Starting dynamic subtest: eDP-1
[344.096335] Dynamic subtest eDP-1: SKIP (0.000s)
[344.100445] Subtest fbc-psr2-suspend: SKIP (0.001s)
[344.166417] [067/132] (677s left) gem_exercise_blt (fast-copy-emit)
[344.220021] Starting subtest: fast-copy-emit
[344.222199] Starting dynamic subtest: linear-smem-smem-emit
[344.240260] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[344.252183] Starting dynamic subtest: xmajor-smem-smem-emit
[344.256860] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[344.266555] Starting dynamic subtest: tile4-smem-smem-emit
[344.274409] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[344.283571] Starting dynamic subtest: tile64-smem-smem-emit
[344.290392] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[344.292667] Subtest fast-copy-emit: SUCCESS (0.074s)
[344.413459] [068/132] (677s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[344.495427] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[344.498722] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[344.574192] [069/132] (676s left) kms_plane_scaling (planes-upscale-factor-0-25)
[344.639916] Starting subtest: planes-upscale-factor-0-25
[344.641714] Starting dynamic subtest: pipe-A
[344.701828] Dynamic subtest pipe-A: SUCCESS (0.062s)
[344.712045] Starting dynamic subtest: pipe-B
[345.848698] Dynamic subtest pipe-B: SUCCESS (1.145s)
[345.860093] Starting dynamic subtest: pipe-C
[346.961860] Dynamic subtest pipe-C: SUCCESS (1.111s)
[346.971849] Starting dynamic subtest: pipe-D
[348.088501] Dynamic subtest pipe-D: SUCCESS (1.126s)
[348.090697] Subtest planes-upscale-factor-0-25: SUCCESS (3.449s)
[349.254398] [070/132] (672s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[349.336284] Starting subtest: yf-tiled-64bpp-rotate-0
[349.340249] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[349.436745] [071/132] (672s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[349.519006] Starting subtest: fbc-rgb565-draw-mmap-gtt
[349.523145] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[349.620434] [072/132] (672s left) kms_flip (flip-vs-rmfb-interruptible)
[349.690669] Starting subtest: flip-vs-rmfb-interruptible
[349.692550] Starting dynamic subtest: A-eDP1
[358.334546] Dynamic subtest A-eDP1: SUCCESS (8.642s)
[358.344840] Starting dynamic subtest: B-eDP1
[366.972935] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[366.987916] Starting dynamic subtest: C-eDP1
[375.598146] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[375.609822] Starting dynamic subtest: D-eDP1
[384.233722] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[384.238368] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.545s)
[385.422307] [073/132] (636s left) kms_flip (2x-plain-flip-fb-recreate)
[385.507345] Starting subtest: 2x-plain-flip-fb-recreate
[385.515535] Subtest 2x-plain-flip-fb-recreate: SKIP (0.007s)
[385.592795] [074/132] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[385.681829] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[392.676193] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.999s)
[392.790139] [075/132] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[392.868724] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[392.872695] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[392.971234] [076/132] (628s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[393.061990] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[393.066213] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[393.163111] [077/132] (628s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[393.250269] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[393.918716] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[394.093479] [078/132] (627s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[394.178865] Starting subtest: basic-modeset-with-all-modifiers-formats
[394.549674] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[395.321008] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.773s)
[395.330993] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[395.343465] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[395.352971] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[395.365585] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[395.375673] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[395.521351] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[395.531487] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[395.543299] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[395.553050] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[395.565687] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[395.578066] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[395.588035] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[395.597647] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[395.610163] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[395.619591] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[395.632558] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[395.642256] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[395.654935] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[395.664131] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[395.676934] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[395.686103] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[395.699178] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[395.708540] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[395.854732] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[395.864157] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[395.877050] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[395.886012] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[395.899122] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[395.914227] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[395.921457] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[395.930560] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[395.943757] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[395.952949] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[395.965860] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[395.974999] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[395.988116] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[395.997361] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[396.009941] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[396.019090] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[396.032520] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[396.041756] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[396.188410] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[396.198123] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[396.210589] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[396.219990] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[396.232543] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[396.241951] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[396.255156] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[396.264322] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[396.277321] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[396.286553] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[396.299295] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[396.308417] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[396.321345] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[396.329954] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[396.343631] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[396.352451] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[396.366392] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[396.750933] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.574s)
[397.611155] [079/132] (624s left) kms_plane_scaling (2x-scaler-multi-pipe)
[397.693779] Starting subtest: 2x-scaler-multi-pipe
[397.698178] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[397.800325] [080/132] (624s left) gem_userptr_blits (sd-probe)
[397.857287] Starting subtest: sd-probe
[397.859479] Subtest sd-probe: SUCCESS (0.000s)
[397.980590] [081/132] (624s left) gem_render_copy (x-tiled)
[398.046366] Starting subtest: x-tiled
[398.048661] Starting dynamic subtest: smem
[398.088057] Dynamic subtest smem: SUCCESS (0.041s)
[398.090537] Subtest x-tiled: SUCCESS (0.042s)
[398.313657] [082/132] (623s left) kms_pm_lpsp (screens-disabled)
[399.402757] Starting subtest: screens-disabled
[399.406953] Subtest screens-disabled: SKIP (0.000s)
[399.473716] [083/132] (622s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[399.575641] Starting subtest: cursor-vs-flip-atomic
[429.380379] Subtest cursor-vs-flip-atomic: SUCCESS (29.805s)
[430.221634] [084/132] (591s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[430.296744] Starting subtest: y-tiled-32bpp-rotate-180
[430.300980] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[430.392133] [085/132] (591s left) i915_fb_tiling (basic-x-tiling)
[430.447890] Subtest basic-x-tiling: SKIP (0.000s)
[430.514953] [086/132] (591s left) gem_pread (exhaustion)
[430.570373] Subtest exhaustion: SKIP (0.000s)
[430.635936] [087/132] (591s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[430.716712] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[431.809527] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.523s)
[431.848248] [088/132] (590s left) gem_ccs (ctrl-surf-copy-new-ctx)
[431.909578] Starting subtest: ctrl-surf-copy-new-ctx
[431.914024] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[432.024366] [089/132] (590s left) kms_atomic_interruptible (atomic-setmode)
[432.100977] Starting subtest: atomic-setmode
[432.102791] Starting dynamic subtest: pipe-A-eDP-1
[439.017077] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.911s)
[439.019317] Subtest atomic-setmode: SUCCESS (6.913s)
[439.882905] [090/132] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[439.962306] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[439.966390] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[440.063336] [091/132] (582s left) i915_pm_sseu (full-enable)
[440.130772] Subtest full-enable: SKIP (0.000s)
[440.230279] [092/132] (582s left) gem_readwrite (beyond-eob)
[440.293691] Subtest beyond-EOB: SKIP (0.000s)
[440.355391] [093/132] (582s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[440.424459] Starting subtest: fbc-rgb101010-draw-render
[445.013431] Subtest fbc-rgb101010-draw-render: SUCCESS (4.592s)
[446.192120] [094/132] (576s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[446.274964] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[446.279385] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[446.350025] [095/132] (576s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[446.719248] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[447.497112] [096/132] (575s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[447.577272] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[448.600267] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.023s)
[448.744843] [097/132] (573s left) gem_exec_reloc (basic-write-wc-active)
[448.805322] Subtest basic-write-wc-active: SKIP (0.000s)
[448.870490] [098/132] (573s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[448.943014] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[448.944938] Starting dynamic subtest: pipe-A-default-mode
[450.078978] Dynamic subtest pipe-A-default-mode: SKIP (1.132s)
[450.083382] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.133s)
[450.213350] [099/132] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[450.292189] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[450.296269] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[450.395454] [100/132] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[450.479214] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[454.882198] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.405s)
[456.055434] [101/132] (566s left) gem_ctx_param (invalid-ctx-get)
[456.108779] Starting subtest: invalid-ctx-get
[456.111266] Subtest invalid-ctx-get: SUCCESS (0.000s)
[456.198858] [102/132] (566s left) kms_lease (atomic-implicit-crtc)
[456.283101] Starting subtest: atomic-implicit-crtc
[456.285353] Starting dynamic subtest: pipe-A-eDP-1
[456.296197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[456.308506] Starting dynamic subtest: pipe-B-eDP-1
[456.319464] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[456.329181] Starting dynamic subtest: pipe-C-eDP-1
[456.339488] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[456.349088] Starting dynamic subtest: pipe-D-eDP-1
[456.359450] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[456.361361] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[456.449534] [103/132] (566s left) core_setmaster (master-drop-set-root)
[456.504485] Starting subtest: master-drop-set-root
[456.529256] Subtest master-drop-set-root: SUCCESS (0.025s)
[456.576717] [104/132] (566s left) kms_cdclk (mode-transition)
[456.658634] Starting subtest: mode-transition
[456.660909] Starting dynamic subtest: pipe-A-eDP-1
[456.956391] Dynamic subtest pipe-A-eDP-1: SKIP (0.294s)
[456.968423] Starting dynamic subtest: pipe-B-eDP-1
[456.972997] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[456.983099] Starting dynamic subtest: pipe-C-eDP-1
[456.987714] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[456.997103] Starting dynamic subtest: pipe-D-eDP-1
[457.001448] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[457.005924] Subtest mode-transition: SKIP (0.301s)
[457.769040] [105/132] (565s left) syncobj_timeline (wait-all-interrupted)
[457.834133] Starting subtest: wait-all-interrupted
[457.935307] Subtest wait-all-interrupted: SUCCESS (0.101s)
[458.014033] [106/132] (565s left) kms_display_modes (extended-mode-basic)
[458.105769] Starting subtest: extended-mode-basic
[458.110130] Subtest extended-mode-basic: SKIP (0.000s)
[458.155437] [107/132] (564s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[458.236306] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[458.240406] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[458.336332] [108/132] (564s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[458.413188] Starting subtest: fbcpsr-tiling-y
[458.417141] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[458.535238] [109/132] (564s left) gem_mmap_offset (partial-mmap)
[458.599581] Starting subtest: partial-mmap
[458.601934] Starting dynamic subtest: smem0
[458.604288] Dynamic subtest smem0: SUCCESS (0.004s)
[458.606278] Subtest partial-mmap: SUCCESS (0.005s)
[458.721783] [110/132] (564s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[458.809051] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[458.810934] Starting dynamic subtest: pipe-A-eDP-1
[458.927522] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[458.937682] Starting dynamic subtest: pipe-B-eDP-1
[460.144587] Dynamic subtest pipe-B-eDP-1: SKIP (1.214s)
[460.148962] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.338s)
[461.333273] [111/132] (561s left) gem_exec_balancer (invalid-balancer)
[461.397770] Starting subtest: invalid-balancer
[462.294767] Subtest invalid-balancer: SUCCESS (0.895s)
[462.590024] [112/132] (560s left) gem_userptr_blits (map-fixed-invalidate)
[462.656551] Starting subtest: map-fixed-invalidate
[462.660975] Subtest map-fixed-invalidate: SKIP (0.000s)
[462.771808] [113/132] (560s left) perf (gen12-group-exclusive-stream-sample-oa)
[462.935977] Starting subtest: gen12-group-exclusive-stream-sample-oa
[462.964477] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.029s)
[463.017413] [114/132] (560s left) kms_fbcon_fbt (psr)
[463.091664] Starting subtest: psr
[470.472595] Subtest psr: SUCCESS (7.379s)
[470.552885] [115/132] (552s left) kms_getfb (getfb2-into-addfb2)
[470.628872] Starting subtest: getfb2-into-addfb2
[470.631099] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[470.728216] [116/132] (552s left) kms_psr (fbc-psr2-cursor-blt)
[470.801781] Starting subtest: fbc-psr2-cursor-blt
[470.804043] Starting dynamic subtest: eDP-1
[470.808094] Dynamic subtest eDP-1: SKIP (0.000s)
[470.812280] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[470.876679] [117/132] (552s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[470.956308] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[478.316104] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.364s)
[478.454871] [118/132] (545s left) gem_exec_capture (capture-recoverable)
[478.519267] Starting subtest: capture-recoverable
[478.521655] Subtest capture-recoverable: SUCCESS (0.003s)
[478.650851] [119/132] (544s left) gem_exec_schedule (preempt-other)
[478.718481] Starting subtest: preempt-other
[478.720402] Starting dynamic subtest: rcs0
[478.780975] Dynamic subtest rcs0: SUCCESS (0.070s)
[478.793570] Starting dynamic subtest: bcs0
[478.846624] Dynamic subtest bcs0: SUCCESS (0.064s)
[478.864724] Starting dynamic subtest: vcs0
[478.912280] Dynamic subtest vcs0: SUCCESS (0.065s)
[478.922650] Starting dynamic subtest: vcs1
[478.980755] Dynamic subtest vcs1: SUCCESS (0.067s)
[478.994568] Starting dynamic subtest: vecs0
[479.048597] Dynamic subtest vecs0: SUCCESS (0.067s)
[479.061770] Starting dynamic subtest: ccs0
[479.115899] Dynamic subtest ccs0: SUCCESS (0.067s)
[479.118604] Subtest preempt-other: SUCCESS (0.406s)
[480.291587] [120/132] (543s left) kms_sequence (queue-idle)
[480.372988] Starting subtest: queue-idle
[480.375277] Starting dynamic subtest: pipe-A-eDP-1
[482.198699] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.825s)
[482.211387] Starting dynamic subtest: pipe-B-eDP-1
[484.674511] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.472s)
[484.686128] Starting dynamic subtest: pipe-C-eDP-1
[487.100475] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s)
[487.111644] Starting dynamic subtest: pipe-D-eDP-1
[489.518738] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.418s)
[489.521105] Subtest queue-idle: SUCCESS (9.146s)
[490.336379] [121/132] (533s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[490.434953] Starting subtest: basic-flip-after-cursor-atomic
[491.350167] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s)
[492.166134] [122/132] (531s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[492.274001] Starting subtest: basic-busy-flip-before-cursor-legacy
[492.278387] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[492.424250] [123/132] (531s left) gem_ccs (large-ctrl-surf-copy)
[492.480121] Starting subtest: large-ctrl-surf-copy
[492.484452] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[492.574238] [124/132] (531s left) kms_cursor_crc (cursor-sliding-32x32)
[492.688293] Starting subtest: cursor-sliding-32x32
[492.732840] Subtest cursor-sliding-32x32: SKIP (0.040s)
[493.003053] [125/132] (530s left) kms_cursor_crc (cursor-random-max-size)
[493.286117] Starting subtest: cursor-random-max-size
[493.291853] Subtest cursor-random-max-size: SKIP (0.000s)
[493.411830] [126/132] (530s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[493.493938] Starting subtest: pixel-format-y-tiled-ccs-modifier
[493.497568] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[493.567840] [127/132] (530s left) gem_render_copy (yf-tiled-ccs-to-linear)
[493.634173] Starting subtest: yf-tiled-ccs-to-linear
[493.637977] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[493.828120] [128/132] (530s left) kms_joiner (basic-max-non-joiner)
[493.898662] Starting subtest: basic-max-non-joiner
[493.903033] Subtest basic-max-non-joiner: SKIP (0.000s)
[493.964812] [129/132] (530s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[494.062138] Starting subtest: cursorA-vs-flipB-atomic
[494.066660] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[494.223887] [130/132] (529s left) i915_drm_fdinfo (memory-info-idle)
[494.270217] Starting subtest: memory-info-idle
[494.272589] Starting dynamic subtest: smem0
[494.315192] Dynamic subtest smem0: SUCCESS (0.046s)
[494.317639] Subtest memory-info-idle: SUCCESS (0.047s)
[494.392274] [131/132] (529s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[494.457918] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[494.460240] Starting dynamic subtest: pipe-A
[494.806935] Dynamic subtest pipe-A: SUCCESS (0.351s)
[494.818241] Starting dynamic subtest: pipe-B
[496.183896] Dynamic subtest pipe-B: SUCCESS (1.376s)
[496.196173] Starting dynamic subtest: pipe-C
[497.645317] Dynamic subtest pipe-C: SUCCESS (1.460s)
[497.654936] Starting dynamic subtest: pipe-D
[499.098493] Dynamic subtest pipe-D: SUCCESS (1.452s)
[499.100806] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.643s)
[500.325524] [132/132] (523s left) api_intel_bb (full-batch)
[500.379953] Starting subtest: full-batch
[500.384762] Subtest full-batch: SUCCESS (0.007s)
[500.496788] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_prop_blob
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: prime_self_import
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_spin_batch
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: kms_color_pipeline
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_pipe_b_c_ivb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_pipe_crc_basic
results: parsing output: 28/ for test: gem_exec_whisper
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_ctx_param
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: prime_busy
results: parsing output: 34/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: sysfs_timeslice_duration
results: parsing output: 37/ for test: gem_exec_gttfill
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: kms_chamelium_edid
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: gem_exec_nop
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: gem_eio
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_atomic
results: parsing output: 53/ for test: kms_feature_discovery
results: parsing output: 54/ for test: gen7_exec_parse
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: gem_ctx_freq
results: parsing output: 58/ for test: gem_partial_pwrite_pread
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: i915_pm_rps
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: testdisplay
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_exercise_blt
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_async_flips
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_pm_lpsp
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: i915_fb_tiling
results: parsing output: 85/ for test: gem_pread
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_ccs
results: parsing output: 88/ for test: kms_atomic_interruptible
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: i915_pm_sseu
results: parsing output: 91/ for test: gem_readwrite
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: core_setmaster
results: parsing output: 103/ for test: kms_cdclk
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_display_modes
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_fbcon_fbt
results: parsing output: 114/ for test: kms_getfb
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_capture
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_sequence
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: gem_ccs
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_joiner
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: i915_drm_fdinfo
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: api_intel_bb
Done.