[57.991966] Initializing watchdogs
[57.992027]   /dev/watchdog0
[58.004953] [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]
[58.009218] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.011323] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.014346] [001/133] (960s left) kms_psr (fbc-pr-sprite-plane-onoff)
[58.157757] Starting subtest: fbc-pr-sprite-plane-onoff
[58.161672] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[58.233203] [002/133] (960s left) gem_mmap (bad-size)
[58.304801] Subtest bad-size: SKIP (0.000s)
[58.359866] [003/133] (960s left) perf (enable-disable)
[58.487520] Starting subtest: enable-disable
[58.489561] Starting dynamic subtest: 0-rcs0
[60.734266] Dynamic subtest 0-rcs0: SUCCESS (2.262s)
[60.741231] Starting dynamic subtest: 1-vcs1
[65.249779] Dynamic subtest 1-vcs1: SUCCESS (4.480s)
[65.252522] Subtest enable-disable: SUCCESS (6.743s)
[65.286163] [004/133] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[65.402045] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[65.406349] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[65.528254] [005/133] (953s left) kms_psr (pr-sprite-blt)
[65.623835] Starting subtest: pr-sprite-blt
[65.628301] Subtest pr-sprite-blt: SKIP (0.000s)
[65.719624] [006/133] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[65.819898] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[65.824291] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[65.948069] [007/133] (952s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[66.044668] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[66.855518] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[67.329510] [008/133] (951s left) kms_fbcon_fbt (psr-suspend)
[67.559686] Starting subtest: psr-suspend
[117.015884] Subtest psr-suspend: SUCCESS (20.365s)
[117.103275] [009/133] (901s left) kms_psr (psr-basic)
[117.217753] Starting subtest: psr-basic
[117.219959] Starting dynamic subtest: eDP-1
[118.777198] Dynamic subtest eDP-1: SUCCESS (1.589s)
[118.779469] Subtest psr-basic: SUCCESS (1.590s)
[119.643054] [010/133] (899s left) kms_cursor_crc (cursor-offscreen-512x170)
[119.931083] Starting subtest: cursor-offscreen-512x170
[119.935731] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[120.091262] [011/133] (898s left) kms_content_protection (atomic-dpms-hdcp14)
[120.236735] Starting subtest: atomic-dpms-hdcp14
[120.241209] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[120.394151] [012/133] (898s left) gem_mmap_wc (copy)
[120.453973] Subtest copy: SKIP (0.000s)
[120.508764] [013/133] (898s left) tools_test (sysfs_l3_parity)
[120.557749] Starting subtest: sysfs_l3_parity
[120.611881] Subtest sysfs_l3_parity: SKIP (0.064s)
[120.674375] [014/133] (898s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[120.774012] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[121.720946] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.959s)
[121.899210] [015/133] (897s left) kms_color (ctm-0-75)
[121.994876] Starting subtest: ctm-0-75
[121.996718] Starting dynamic subtest: pipe-A-eDP-1
[126.784639] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.828s)
[126.794146] Starting dynamic subtest: pipe-B-eDP-1
[132.356737] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.597s)
[132.364674] Starting dynamic subtest: pipe-C-eDP-1
[137.650088] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.306s)
[137.659812] Starting dynamic subtest: pipe-D-eDP-1
[142.971605] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.329s)
[142.974027] Subtest ctm-0-75: SUCCESS (21.062s)
[143.798593] [016/133] (875s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[143.905659] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[143.907972] Starting dynamic subtest: pipe-A-eDP-1
[143.965597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[144.281515] Starting dynamic subtest: pipe-B-eDP-1
[145.097287] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.823s)
[145.396804] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.491s)
[146.271552] [017/133] (872s left) gem_exec_whisper (basic-fds-forked)
[146.332047] Starting subtest: basic-fds-forked
[169.519378] Subtest basic-fds-forked: SUCCESS (23.178s)
[169.719626] [018/133] (849s left) kms_lease (lease-again)
[169.827293] Starting subtest: lease-again
[169.829536] Starting dynamic subtest: pipe-A-eDP-1
[169.831804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[169.841007] Starting dynamic subtest: pipe-B-eDP-1
[169.842886] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[169.850725] Starting dynamic subtest: pipe-C-eDP-1
[169.852571] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[169.860315] Starting dynamic subtest: pipe-D-eDP-1
[169.862493] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[169.864331] Subtest lease-again: SUCCESS (0.011s)
[169.997342] [019/133] (849s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[170.099374] Starting subtest: plane-all-transition-nonblocking-fencing
[170.101709] Starting dynamic subtest: pipe-A-eDP-1
[172.594993] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[172.905450] Starting dynamic subtest: pipe-B-eDP-1
[176.101666] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.205s)
[176.411906] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.313s)
[177.252150] [020/133] (842s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[177.529856] Starting subtest: cursor-rapid-movement-512x170
[177.534257] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[177.708128] [021/133] (841s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[177.776466] Starting subtest: yf-tiled-to-vebox-y-tiled
[177.780827] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[177.972916] [022/133] (841s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[178.035421] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[178.135803] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s)
[178.218936] [023/133] (841s left) gem_render_copy (yf-tiled-ccs-to-linear)
[178.287256] Starting subtest: yf-tiled-ccs-to-linear
[178.291348] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[178.481826] [024/133] (840s left) gem_spin_batch (spin-all)
[178.548232] Starting subtest: spin-all
[178.563449] Subtest spin-all: SUCCESS (0.013s)
[180.445688] [025/133] (839s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[180.537895] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[180.568677] Starting dynamic subtest: pipe-A-plane-0
[180.573146] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[180.583669] Starting dynamic subtest: pipe-A-plane-3
[180.588138] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[180.597961] Starting dynamic subtest: pipe-A-plane-5
[180.602283] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[181.635044] Starting dynamic subtest: pipe-B-plane-0
[181.641014] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[181.651190] Starting dynamic subtest: pipe-B-plane-3
[181.655687] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[181.664561] Starting dynamic subtest: pipe-B-plane-5
[181.669846] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[181.938712] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (1.398s)
[182.815774] [026/133] (836s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[182.918976] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[182.923154] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[183.045736] [027/133] (836s left) gem_exec_fence (syncobj-timeline-chain-engines)
[183.626431] Starting subtest: syncobj-timeline-chain-engines
[183.720729] Subtest syncobj-timeline-chain-engines: SUCCESS (0.095s)
[185.509113] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[185.512494] [028/133] (834s left) gem_exec_create (madvise)
[185.569524] Starting subtest: madvise
[185.572083] Starting dynamic subtest: smem
[207.472574] Dynamic subtest smem: SUCCESS (21.902s)
[207.475184] Subtest madvise: SUCCESS (21.902s)
[208.319932] [029/133] (811s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[208.720445] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[209.500420] [030/133] (810s left) kms_psr2_su (page_flip-nv12)
[209.556472] Subtest page_flip-NV12: SKIP (0.000s)
[209.615793] [031/133] (810s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[209.715852] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[214.174959] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.461s)
[215.342455] [032/133] (804s left) kms_plane_alpha_blend (alpha-opaque-fb)
[215.441622] Starting subtest: alpha-opaque-fb
[215.872093] Starting dynamic subtest: pipe-A-eDP-1
[216.491262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.616s)
[216.500410] Starting dynamic subtest: pipe-D-eDP-1
[217.851955] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.360s)
[217.854211] Subtest alpha-opaque-fb: SUCCESS (2.410s)
[218.712802] [033/133] (801s left) gem_partial_pwrite_pread (write-uncached)
[218.788141] Subtest write-uncached: SKIP (0.000s)
[218.862642] [034/133] (800s left) gem_softpin (invalid)
[218.916868] Starting subtest: invalid
[218.925235] Subtest invalid: SUCCESS (0.006s)
[219.060612] [035/133] (800s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[219.126431] Starting subtest: single-wait-for-submit-available-signaled
[219.128660] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[219.248207] [036/133] (800s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[219.346015] Starting subtest: y-tiled-32bpp-rotate-270
[219.350413] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[219.449749] [037/133] (800s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[219.573019] Starting subtest: cursorA-vs-flipB-atomic
[219.577530] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[219.723327] [038/133] (800s left) i915_selftest (live)
[223.200109] Starting subtest: live
[223.203141] Starting dynamic subtest: sanitycheck
[227.636824] Dynamic subtest sanitycheck: SUCCESS (4.435s)
[227.646465] Starting dynamic subtest: uncore
[230.504878] Dynamic subtest uncore: SUCCESS (2.865s)
[230.514486] Starting dynamic subtest: workarounds
[233.870357] Dynamic subtest workarounds: SUCCESS (3.362s)
[233.879991] Starting dynamic subtest: gt_engines
[238.576495] Dynamic subtest gt_engines: SUCCESS (4.703s)
[238.585739] Starting dynamic subtest: gt_timelines
[253.996709] Dynamic subtest gt_timelines: SUCCESS (15.418s)
[254.006416] Starting dynamic subtest: gt_contexts
[258.452506] Dynamic subtest gt_contexts: SUCCESS (4.453s)
[258.462250] Starting dynamic subtest: gt_lrc
[262.916049] Dynamic subtest gt_lrc: SUCCESS (4.462s)
[262.924263] Starting dynamic subtest: gt_mocs
[267.969933] Dynamic subtest gt_mocs: SUCCESS (5.052s)
[267.979922] Starting dynamic subtest: gt_pm
[274.982997] Dynamic subtest gt_pm: SUCCESS (7.011s)
[274.992567] Starting dynamic subtest: gt_heartbeat
[279.791570] Dynamic subtest gt_heartbeat: SUCCESS (4.807s)
[279.810762] Starting dynamic subtest: gt_tlb
[289.453976] Dynamic subtest gt_tlb: SUCCESS (9.662s)
[289.463464] Starting dynamic subtest: requests
[300.948385] Dynamic subtest requests: SUCCESS (11.491s)
[300.957599] Starting dynamic subtest: migrate
[308.868355] Dynamic subtest migrate: SUCCESS (7.924s)
[308.877566] Starting dynamic subtest: active
[313.370300] Dynamic subtest active: SUCCESS (4.501s)
[313.379624] Starting dynamic subtest: objects
[318.248163] Dynamic subtest objects: SUCCESS (4.876s)
[318.257597] Starting dynamic subtest: mman
[323.249455] Dynamic subtest mman: SUCCESS (5.000s)
[323.259307] Starting dynamic subtest: dmabuf
[327.759552] Dynamic subtest dmabuf: SUCCESS (4.509s)
[327.769458] Starting dynamic subtest: vma
[332.235104] Dynamic subtest vma: SUCCESS (4.474s)
[332.244317] Starting dynamic subtest: coherency
[337.292351] Dynamic subtest coherency: SUCCESS (5.057s)
[337.301968] Starting dynamic subtest: gtt
[347.267931] Dynamic subtest gtt: SUCCESS (9.969s)
[347.277348] Starting dynamic subtest: gem
[355.191097] Dynamic subtest gem: SUCCESS (7.919s)
[355.205651] Starting dynamic subtest: evict
[360.630641] Dynamic subtest evict: SUCCESS (5.436s)
[360.640440] Starting dynamic subtest: hugepages
[369.743484] Dynamic subtest hugepages: SUCCESS (9.109s)
[369.752487] Starting dynamic subtest: gem_contexts
[398.072232] Dynamic subtest gem_contexts: SUCCESS (28.324s)
[398.082160] Starting dynamic subtest: client
[402.535997] Dynamic subtest client: SUCCESS (4.463s)
[402.545829] Starting dynamic subtest: gem_migrate
[407.029074] Dynamic subtest gem_migrate: SUCCESS (4.490s)
[407.039045] Starting dynamic subtest: reset
[409.950515] Dynamic subtest reset: SUCCESS (2.919s)
[409.959989] Starting dynamic subtest: memory_region
[414.448166] Dynamic subtest memory_region: SUCCESS (4.496s)
[414.456901] Starting dynamic subtest: hangcheck
[427.538668] Dynamic subtest hangcheck: SUCCESS (13.088s)
[427.553089] Starting dynamic subtest: execlists
[430.289419] Dynamic subtest execlists: SUCCESS (2.749s)
[430.299239] Starting dynamic subtest: ring_submission
[434.749927] Dynamic subtest ring_submission: SUCCESS (4.458s)
[434.759278] Starting dynamic subtest: perf
[437.726840] Dynamic subtest perf: SUCCESS (2.975s)
[437.736427] Starting dynamic subtest: slpc
[451.889744] Dynamic subtest slpc: SUCCESS (14.161s)
[451.899482] Starting dynamic subtest: guc
[455.871122] Dynamic subtest guc: SUCCESS (3.980s)
[455.880548] Starting dynamic subtest: guc_multi_lrc
[460.330675] Dynamic subtest guc_multi_lrc: SUCCESS (4.458s)
[460.340479] Starting dynamic subtest: guc_hang
[465.401711] Dynamic subtest guc_hang: SUCCESS (5.069s)
[465.411456] Starting dynamic subtest: late_gt_pm
[469.870744] Dynamic subtest late_gt_pm: SUCCESS (4.467s)
[469.873455] Subtest live: SUCCESS (246.674s)
[469.901254] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[469.901949] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[469.905189] [039/133] (550s left) perf_pmu (busy-hang)
[471.585490] Starting subtest: busy-hang
[471.589248] Starting dynamic subtest: rcs0
[472.825315] Dynamic subtest rcs0: SUCCESS (1.236s)
[472.835964] Starting dynamic subtest: bcs0
[473.993534] Dynamic subtest bcs0: SUCCESS (1.170s)
[474.004582] Starting dynamic subtest: vcs0
[475.913646] Dynamic subtest vcs0: SUCCESS (1.914s)
[475.930963] Starting dynamic subtest: vcs1
[477.874457] Dynamic subtest vcs1: SUCCESS (1.963s)
[477.885842] Starting dynamic subtest: vecs0
[479.860497] Dynamic subtest vecs0: SUCCESS (1.984s)
[479.871471] Starting dynamic subtest: ccs0
[481.032145] Dynamic subtest ccs0: SUCCESS (1.166s)
[481.034492] Subtest busy-hang: SUCCESS (9.445s)
[481.088879] [FACT perf_pmu (busy-hang)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[481.090012] [FACT perf_pmu (busy-hang)] new: kernel.kmod_is_loaded.i915: true
[481.093801] [040/133] (538s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[481.198865] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[481.203087] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[481.325521] [041/133] (538s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[481.412611] Starting subtest: plane-all-modeset-transition-internal-panels
[481.414456] Starting dynamic subtest: pipe-A-eDP-1
[482.700690] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.288s)
[482.979227] Starting dynamic subtest: pipe-B-eDP-1
[484.020845] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[484.299653] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.887s)
[485.150765] [042/133] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[485.253676] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[485.257542] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[485.374502] [043/133] (534s left) gem_userptr_blits (unsync-unmap-cycles)
[485.446535] Subtest unsync-unmap-cycles: SKIP (0.000s)
[485.606495] [044/133] (534s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[485.699422] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[485.701612] Starting dynamic subtest: pipe-A-eDP-1
[485.723167] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.733463] Starting dynamic subtest: pipe-B-eDP-1
[485.754088] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.762543] Starting dynamic subtest: pipe-C-eDP-1
[485.783283] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[485.792240] Starting dynamic subtest: pipe-D-eDP-1
[485.815358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[485.819986] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[487.936753] [045/133] (532s left) kms_addfb_basic (bad-pitch-128)
[487.999156] Starting subtest: bad-pitch-128
[488.001140] Subtest bad-pitch-128: SUCCESS (0.000s)
[488.159011] [046/133] (532s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[488.261832] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[488.266233] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[488.370268] [047/133] (531s left) gem_ctx_shared (exec-single-timeline)
[488.441154] Starting subtest: exec-single-timeline
[488.443594] Starting dynamic subtest: rcs0
[489.482432] Dynamic subtest rcs0: SUCCESS (1.039s)
[489.494462] Starting dynamic subtest: bcs0
[490.569358] Dynamic subtest bcs0: SUCCESS (1.083s)
[490.581653] Starting dynamic subtest: vcs0
[491.665474] Dynamic subtest vcs0: SUCCESS (1.086s)
[491.679275] Starting dynamic subtest: vcs1
[492.745781] Dynamic subtest vcs1: SUCCESS (1.085s)
[492.758193] Starting dynamic subtest: vecs0
[493.834018] Dynamic subtest vecs0: SUCCESS (1.085s)
[493.845445] Starting dynamic subtest: ccs0
[494.921468] Dynamic subtest ccs0: SUCCESS (1.085s)
[494.924493] Subtest exec-single-timeline: SUCCESS (6.481s)
[495.135132] [048/133] (525s left) gem_madvise (dontneed-before-mmap)
[495.172551] Starting subtest: dontneed-before-mmap
[495.193665] Subtest dontneed-before-mmap: SUCCESS (0.024s)
[495.306097] [049/133] (525s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[495.411493] Starting subtest: flip-primary-invalidate-overlay
[507.023320] Subtest flip-primary-invalidate-overlay: SUCCESS (11.615s)
[507.209891] [050/133] (513s left) gen9_exec_parse (bb-secure)
[507.277860] Subtest bb-secure: SKIP (0.000s)
[507.358904] [051/133] (513s left) gem_mmap_offset (partial-mmap)
[507.423201] Starting subtest: partial-mmap
[507.425040] Starting dynamic subtest: smem0
[507.426937] Dynamic subtest smem0: SUCCESS (0.004s)
[507.428524] Subtest partial-mmap: SUCCESS (0.004s)
[507.590439] [052/133] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[507.695139] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[507.698601] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[507.809634] [053/133] (512s left) kms_atomic (atomic-invalid-params)
[507.903636] Starting subtest: atomic-invalid-params
[507.905215] Starting dynamic subtest: pipe-A-eDP-1
[508.291259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[508.293482] Subtest atomic-invalid-params: SUCCESS (0.387s)
[509.177434] [054/133] (511s left) kms_addfb_basic (master-rmfb)
[509.235434] Starting subtest: master-rmfb
[509.237595] Subtest master-rmfb: SUCCESS (0.001s)
[509.389634] [055/133] (511s left) kms_pm_rpm (system-suspend-idle)
[511.510846] Starting subtest: system-suspend-idle
[531.438432] Subtest system-suspend-idle: SUCCESS (4.550s)
[531.837646] [056/133] (488s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[531.953187] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[532.766845] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[533.038071] [057/133] (487s left) prime_vgem (fence-write-hang)
[533.139880] Subtest fence-write-hang: SKIP (0.000s)
[533.279000] [058/133] (487s left) kms_chamelium_color (ctm-green-to-red)
[533.384137] Subtest ctm-green-to-red: SKIP (0.000s)
[533.432283] [059/133] (487s left) gem_exec_capture (userptr)
[533.498027] Starting subtest: userptr
[534.328835] Subtest userptr: SUCCESS (0.847s)
[534.477916] [060/133] (486s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[534.577919] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[534.580144] Starting dynamic subtest: pipe-A-eDP-1
[534.599146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[534.608541] Starting dynamic subtest: pipe-B-eDP-1
[534.626920] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[534.635521] Starting dynamic subtest: pipe-C-eDP-1
[534.653892] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[534.662303] Starting dynamic subtest: pipe-D-eDP-1
[534.680320] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[534.682364] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[536.786103] [061/133] (484s left) prime_vgem (fence-wait)
[536.867767] Starting subtest: fence-wait
[536.869684] Starting dynamic subtest: rcs0
[537.914075] Dynamic subtest rcs0: SUCCESS (1.060s)
[537.926539] Starting dynamic subtest: bcs0
[538.980496] Dynamic subtest bcs0: SUCCESS (1.077s)
[538.992673] Starting dynamic subtest: vcs0
[540.030593] Dynamic subtest vcs0: SUCCESS (1.059s)
[540.042324] Starting dynamic subtest: vcs1
[541.072709] Dynamic subtest vcs1: SUCCESS (1.050s)
[541.084527] Starting dynamic subtest: vecs0
[542.113743] Dynamic subtest vecs0: SUCCESS (1.047s)
[542.125846] Starting dynamic subtest: ccs0
[543.157315] Dynamic subtest ccs0: SUCCESS (1.049s)
[543.159749] Subtest fence-wait: SUCCESS (6.353s)
[543.303203] [062/133] (477s left) gem_exec_reloc (basic-gtt-active)
[543.363772] Subtest basic-gtt-active: SKIP (0.000s)
[543.441993] [063/133] (477s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[543.541105] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[543.545400] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[543.637506] [064/133] (477s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[543.702975] Starting subtest: invalid-multi-wait-unsubmitted
[543.705332] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[543.838280] [065/133] (477s left) gem_exec_flush (basic-wb-pro-default)
[543.910978] Starting subtest: basic-wb-pro-default
[549.378461] Subtest basic-wb-pro-default: SUCCESS (5.465s)
[549.551658] [066/133] (471s left) gem_blits (basic)
[549.617063] Starting subtest: basic
[551.817446] Subtest basic: SUCCESS (2.152s)
[551.907489] [067/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[552.014622] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[552.018913] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[552.148439] [068/133] (469s left) kms_hdr (bpc-switch-suspend)
[552.238377] Starting subtest: bpc-switch-suspend
[553.338765] Starting dynamic subtest: pipe-A-eDP-1
[573.106571] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.570s)
[573.109248] Subtest bpc-switch-suspend: SUCCESS (5.676s)
[573.259693] [069/133] (448s left) kms_plane_multiple (2x-tiling-x)
[573.360966] Starting subtest: 2x-tiling-x
[573.365447] Subtest 2x-tiling-x: SKIP (0.000s)
[573.442370] [070/133] (447s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[573.547800] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[573.550295] Starting dynamic subtest: pipe-A-eDP-1
[573.574676] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[573.585730] Starting dynamic subtest: pipe-B-eDP-1
[573.609973] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[573.618923] Starting dynamic subtest: pipe-C-eDP-1
[573.643611] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[573.652549] Starting dynamic subtest: pipe-D-eDP-1
[573.677754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[573.682807] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[575.740407] [071/133] (445s left) vgem_basic (bad-flag)
[575.785656] Starting subtest: bad-flag
[575.788379] Subtest bad-flag: SUCCESS (0.000s)
[575.852086] [072/133] (445s left) gem_exec_schedule (u-semaphore-resolve)
[575.931319] Starting subtest: u-semaphore-resolve
[575.958610] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[576.311761] [073/133] (445s left) kms_cursor_crc (cursor-size-change)
[576.403802] Starting subtest: cursor-size-change
[576.406508] Starting dynamic subtest: pipe-A-eDP-1
[577.209792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s)
[577.219961] Starting dynamic subtest: pipe-D-eDP-1
[578.647599] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.462s)
[578.649668] Subtest cursor-size-change: SUCCESS (2.288s)
[579.460047] [074/133] (442s left) gem_ppgtt (flink-and-close-vma-leak)
[579.534633] Starting subtest: flink-and-close-vma-leak
[579.578818] Subtest flink-and-close-vma-leak: SUCCESS (0.045s)
[579.743116] [075/133] (441s left) gem_compute (compute-square)
[579.797238] Starting subtest: compute-square
[579.802882] Subtest compute-square: SUCCESS (0.007s)
[579.951273] [076/133] (441s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[582.277832] Starting subtest: dpms-mode-unset-lpsp
[586.317839] Subtest dpms-mode-unset-lpsp: SUCCESS (4.075s)
[586.725473] [077/133] (434s left) gem_exec_reloc (basic-cpu-read-noreloc)
[586.793907] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[586.888833] [078/133] (434s left) kms_cursor_legacy (torture-bo)
[587.008283] Starting subtest: torture-bo
[587.010651] Starting dynamic subtest: pipe-A
[592.873549] Dynamic subtest pipe-A: SUCCESS (5.887s)
[592.889853] Starting dynamic subtest: pipe-B
[599.793835] Dynamic subtest pipe-B: SUCCESS (6.933s)
[599.803784] Starting dynamic subtest: pipe-C
[607.112319] Dynamic subtest pipe-C: SUCCESS (7.321s)
[607.124677] Starting dynamic subtest: pipe-D
[614.759545] Dynamic subtest pipe-D: SUCCESS (7.644s)
[614.771577] Starting dynamic subtest: all-pipes
[621.899766] Dynamic subtest all-pipes: SUCCESS (7.136s)
[621.902440] Subtest torture-bo: SUCCESS (34.933s)
[622.068953] [079/133] (399s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[622.199799] Starting subtest: fbcpsr-slowdraw
[647.406886] Subtest fbcpsr-slowdraw: SUCCESS (25.216s)
[647.551845] [080/133] (374s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[647.671050] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[647.676218] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[647.776226] [081/133] (374s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[647.882860] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[647.888539] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[648.007767] [082/133] (373s left) gem_ctx_persistence (engines-cleanup)
[648.061879] Starting subtest: engines-cleanup
[648.064565] Starting dynamic subtest: rcs0
[648.172756] Dynamic subtest rcs0: SUCCESS (0.114s)
[648.186817] Starting dynamic subtest: bcs0
[648.240347] Dynamic subtest bcs0: SUCCESS (0.065s)
[648.252962] Starting dynamic subtest: vcs0
[648.287704] Dynamic subtest vcs0: SUCCESS (0.045s)
[648.299624] Starting dynamic subtest: vcs1
[648.345846] Dynamic subtest vcs1: SUCCESS (0.056s)
[648.358308] Starting dynamic subtest: vecs0
[648.404140] Dynamic subtest vecs0: SUCCESS (0.056s)
[648.416882] Starting dynamic subtest: ccs0
[648.445831] Dynamic subtest ccs0: SUCCESS (0.040s)
[648.448157] Subtest engines-cleanup: SUCCESS (0.389s)
[648.538463] [083/133] (373s left) gem_exec_reloc (basic-wc-read-noreloc)
[648.603177] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[648.689580] [084/133] (373s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[648.787423] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[655.682533] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.899s)
[655.857869] [085/133] (366s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[655.915975] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[655.918840] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[656.054116] [086/133] (365s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[656.154708] Starting subtest: psr-rgb565-draw-mmap-wc
[662.893960] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.742s)
[663.062469] [087/133] (359s left) kms_panel_fitting (atomic-fastset)
[663.172014] Starting subtest: atomic-fastset
[663.174964] Starting dynamic subtest: pipe-A-eDP-1
[663.333757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.165s)
[663.345982] Starting dynamic subtest: pipe-B-eDP-1
[664.557970] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s)
[664.570756] Starting dynamic subtest: pipe-C-eDP-1
[665.746981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[665.760147] Starting dynamic subtest: pipe-D-eDP-1
[666.876681] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[666.879567] Subtest atomic-fastset: SUCCESS (3.709s)
[668.133385] [088/133] (353s left) kms_addfb_basic (small-bo)
[668.228835] Starting subtest: small-bo
[668.231394] Subtest small-bo: SUCCESS (0.000s)
[668.350806] [089/133] (353s left) kms_dsc (dsc-with-bpc-formats)
[668.463882] Starting subtest: dsc-with-bpc-formats
[668.597577] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[668.637611] [090/133] (353s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[668.738815] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[673.133832] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.398s)
[674.358654] [091/133] (347s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[674.468961] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[674.474249] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[674.546206] [092/133] (347s left) device_reset (unbind-cold-reset-rebind)
[674.594500] Starting subtest: unbind-cold-reset-rebind
[674.600580] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[674.670195] [093/133] (347s left) gem_vm_create (invalid-create)
[674.741985] Starting subtest: invalid-create
[674.745227] Subtest invalid-create: SUCCESS (0.002s)
[674.869353] [094/133] (347s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[674.965197] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[674.967782] Starting dynamic subtest: pipe-A-eDP-1
[675.043827] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[675.054866] Starting dynamic subtest: pipe-B-eDP-1
[675.133995] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[675.144968] Starting dynamic subtest: pipe-C-eDP-1
[675.221713] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[675.232014] Starting dynamic subtest: pipe-D-eDP-1
[675.300651] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[675.305653] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.013s)
[677.290658] [095/133] (345s left) gem_exec_whisper (basic-queues-forked)
[677.355139] Starting subtest: basic-queues-forked
[700.342271] Subtest basic-queues-forked: SUCCESS (22.979s)
[700.545425] [096/133] (321s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[700.643729] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[707.300821] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.659s)
[707.428616] [097/133] (315s left) gen9_exec_parse (valid-registers)
[707.498843] Subtest valid-registers: SKIP (0.000s)
[707.573613] [098/133] (314s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[707.661949] Starting subtest: fbc-psr2-sprite-mmap-gtt
[707.664351] Starting dynamic subtest: eDP-1
[707.668991] Dynamic subtest eDP-1: SKIP (0.000s)
[707.673968] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[707.751046] [099/133] (314s left) api_intel_bb (full-batch)
[707.805005] Starting subtest: full-batch
[707.810597] Subtest full-batch: SUCCESS (0.008s)
[707.939374] [100/133] (314s left) gem_exec_schedule (fairslice)
[708.006768] Starting subtest: fairslice
[708.009525] Starting dynamic subtest: rcs0
[710.020261] Dynamic subtest rcs0: SUCCESS (2.020s)
[710.030980] Starting dynamic subtest: bcs0
[712.037717] Dynamic subtest bcs0: SUCCESS (2.018s)
[712.049514] Starting dynamic subtest: vcs0
[714.104836] Dynamic subtest vcs0: SUCCESS (2.018s)
[714.115555] Starting dynamic subtest: vcs1
[716.072683] Dynamic subtest vcs1: SUCCESS (2.017s)
[716.086161] Starting dynamic subtest: vecs0
[718.142780] Dynamic subtest vecs0: SUCCESS (2.018s)
[718.154984] Starting dynamic subtest: ccs0
[720.113962] Dynamic subtest ccs0: SUCCESS (2.022s)
[720.116607] Subtest fairslice: SUCCESS (12.118s)
[720.434622] [101/133] (302s left) perf_pmu (rc6-suspend)
[720.477291] Starting subtest: rc6-suspend
[743.191289] Subtest rc6-suspend: SUCCESS (7.595s)
[744.229176] [102/133] (278s left) kms_plane_scaling (planes-downscale-factor-0-5)
[744.320124] Starting subtest: planes-downscale-factor-0-5
[744.322200] Starting dynamic subtest: pipe-A
[744.339203] Dynamic subtest pipe-A: SKIP (0.017s)
[744.352588] Starting dynamic subtest: pipe-B
[744.377643] Dynamic subtest pipe-B: SKIP (0.035s)
[744.389181] Starting dynamic subtest: pipe-C
[744.407033] Dynamic subtest pipe-C: SKIP (0.030s)
[744.416871] Starting dynamic subtest: pipe-D
[744.436537] Dynamic subtest pipe-D: SKIP (0.030s)
[744.439971] Subtest planes-downscale-factor-0-5: SKIP (0.114s)
[744.555349] [103/133] (278s left) syncobj_timeline (invalid-signal-bad-pad)
[744.617846] Starting subtest: invalid-signal-bad-pad
[744.620207] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[744.751070] [104/133] (278s left) kms_invalid_mode (uint-max-clock)
[744.850255] Starting subtest: uint-max-clock
[744.852637] Starting dynamic subtest: pipe-A-eDP-1
[745.142076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[745.153376] Starting dynamic subtest: pipe-B-eDP-1
[745.155913] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[745.167305] Starting dynamic subtest: pipe-C-eDP-1
[745.170027] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[745.179655] Starting dynamic subtest: pipe-D-eDP-1
[745.182032] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[745.184360] Subtest uint-max-clock: SUCCESS (0.297s)
[746.022567] [105/133] (276s left) gem_exec_basic (basic)
[746.081165] Starting subtest: basic
[746.084171] Starting dynamic subtest: rcs0-smem
[746.087147] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[746.099003] Starting dynamic subtest: bcs0-smem
[746.101253] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[746.111212] Starting dynamic subtest: vcs0-smem
[746.113671] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[746.122966] Starting dynamic subtest: vcs1-smem
[746.125200] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[746.134382] Starting dynamic subtest: vecs0-smem
[746.136827] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[746.146274] Starting dynamic subtest: ccs0-smem
[746.148786] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[746.151123] Subtest basic: SUCCESS (0.017s)
[747.193003] [106/133] (275s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[747.288439] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[747.300393] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[747.408999] [107/133] (275s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[747.472645] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[747.577762] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[747.667130] [108/133] (275s left) gem_pxp (display-protected-crc)
[747.786387] Starting subtest: display-protected-crc
[749.386880] Subtest display-protected-crc: SUCCESS (1.601s)
[749.540313] [109/133] (273s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[749.651607] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[749.662428] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[749.784660] [110/133] (273s left) kms_big_fb (x-tiled-addfb)
[749.890397] Starting subtest: x-tiled-addfb
[749.893194] Subtest x-tiled-addfb: SUCCESS (0.000s)
[750.014159] [111/133] (273s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[750.108252] Starting subtest: plane-scaler-unity-scaling-with-rotation
[750.111014] Starting dynamic subtest: pipe-A
[750.333998] Dynamic subtest pipe-A: SUCCESS (0.228s)
[750.344016] Starting dynamic subtest: pipe-B
[751.611047] Dynamic subtest pipe-B: SUCCESS (1.275s)
[751.620350] Starting dynamic subtest: pipe-C
[752.950197] Dynamic subtest pipe-C: SUCCESS (1.337s)
[752.959948] Starting dynamic subtest: pipe-D
[754.301018] Dynamic subtest pipe-D: SUCCESS (1.349s)
[754.303854] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.194s)
[755.564190] [112/133] (267s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[755.676383] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[755.681394] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[755.792195] [113/133] (267s left) kms_chamelium_edid (dp-edid-resolution-list)
[756.184110] Subtest dp-edid-resolution-list: SKIP (0.000s)
[756.968356] [114/133] (266s left) gem_exec_schedule (out-order)
[757.044140] Starting subtest: out-order
[757.046706] Starting dynamic subtest: rcs0
[757.138989] Dynamic subtest rcs0: SUCCESS (0.106s)
[757.151315] Starting dynamic subtest: vcs0
[757.223447] Dynamic subtest vcs0: SUCCESS (0.083s)
[757.236657] Starting dynamic subtest: vcs1
[757.306133] Dynamic subtest vcs1: SUCCESS (0.082s)
[757.319111] Starting dynamic subtest: vecs0
[757.387298] Dynamic subtest vecs0: SUCCESS (0.081s)
[757.400973] Starting dynamic subtest: ccs0
[757.469026] Dynamic subtest ccs0: SUCCESS (0.081s)
[757.471774] Subtest out-order: SUCCESS (0.437s)
[759.302906] [115/133] (263s left) i915_hangman (gt-error-state-capture)
[759.368069] Starting subtest: gt-error-state-capture
[759.370719] Starting dynamic subtest: rcs0
[771.108146] Dynamic subtest rcs0: SUCCESS (11.736s)
[771.121520] Starting dynamic subtest: bcs0
[783.139313] Dynamic subtest bcs0: SUCCESS (12.027s)
[783.153322] Starting dynamic subtest: vcs0
[795.042810] Dynamic subtest vcs0: SUCCESS (11.899s)
[795.054625] Starting dynamic subtest: vcs1
[807.075462] Dynamic subtest vcs1: SUCCESS (12.028s)
[807.097143] Starting dynamic subtest: vecs0
[819.107397] Dynamic subtest vecs0: SUCCESS (12.027s)
[819.129376] Starting dynamic subtest: ccs0
[831.076522] Dynamic subtest ccs0: SUCCESS (11.965s)
[831.079360] Subtest gt-error-state-capture: SUCCESS (71.700s)
[831.228105] [116/133] (192s left) i915_pm_rps (basic-api)
[831.322994] Starting subtest: basic-api
[831.329117] Subtest basic-api: SKIP (0.001s)
[831.480793] [117/133] (191s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[831.583471] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[831.589102] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[831.707652] [118/133] (191s left) gem_ctx_shared (create-shared-gtt)
[831.766382] Starting subtest: create-shared-gtt
[833.920934] Subtest create-shared-gtt: SUCCESS (2.152s)
[834.236780] [119/133] (189s left) drm_read (short-buffer-nonblock)
[834.382913] Starting subtest: short-buffer-nonblock
[834.385698] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[834.540826] [120/133] (189s left) kms_busy (extended-pageflip-hang-newfb)
[834.644936] Starting subtest: extended-pageflip-hang-newfb
[834.647827] Starting dynamic subtest: pipe-A
[860.960370] Dynamic subtest pipe-A: SUCCESS (26.315s)
[860.971191] Starting dynamic subtest: pipe-D
[885.912563] Dynamic subtest pipe-D: SUCCESS (24.949s)
[885.914891] Subtest extended-pageflip-hang-newfb: SUCCESS (51.269s)
[886.752437] [121/133] (136s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[886.856642] Starting subtest: fbc-psr2-cursor-plane-update-sf
[886.859266] Starting dynamic subtest: pipe-A-eDP-1
[886.928195] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[886.941150] Starting dynamic subtest: pipe-B-eDP-1
[888.035301] Dynamic subtest pipe-B-eDP-1: SKIP (1.104s)
[888.040869] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.183s)
[889.242850] [122/133] (134s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[889.342208] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[889.347265] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[889.426024] [123/133] (134s left) gem_close (many-handles-one-vma)
[889.480147] Starting subtest: many-handles-one-vma
[889.502963] Subtest many-handles-one-vma: SUCCESS (0.025s)
[889.608951] [124/133] (134s left) kms_flip (blocking-wf_vblank)
[889.699011] Starting subtest: blocking-wf_vblank
[889.701502] Starting dynamic subtest: A-eDP1
[898.621161] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[898.637773] Starting dynamic subtest: B-eDP1
[907.558114] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[907.574340] Starting dynamic subtest: C-eDP1
[916.490891] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[916.503766] Starting dynamic subtest: D-eDP1
[925.431086] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[925.433997] Subtest blocking-wf_vblank: SUCCESS (35.690s)
[926.632296] [125/133] ( 97s left) gem_flink_basic (double-flink)
[926.698369] Starting subtest: double-flink
[926.701198] Subtest double-flink: SUCCESS (0.000s)
[926.817693] [126/133] ( 96s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[926.918463] Starting subtest: fbc-rgb565-draw-mmap-gtt
[926.923679] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[927.039848] [127/133] ( 96s left) syncobj_wait (multi-wait-all-submitted-signaled)
[927.110042] Starting subtest: multi-wait-all-submitted-signaled
[927.217745] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[927.307099] [128/133] ( 96s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[927.432197] Starting subtest: cursorB-vs-flipA-varying-size
[927.436910] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[927.595924] [129/133] ( 96s left) kms_cursor_crc (cursor-tearing-position-change)
[927.728928] Starting subtest: cursor-tearing-position-change
[927.731179] Starting dynamic subtest: pipe-A-eDP-1
[928.357920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s)
[928.369406] Starting dynamic subtest: pipe-D-eDP-1
[929.567192] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s)
[929.569726] Subtest cursor-tearing-position-change: SUCCESS (1.839s)
[930.403873] [130/133] ( 93s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[930.464613] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[930.467185] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[930.573757] [131/133] ( 93s left) kms_selftest (drm_format)
[930.612973] Starting subtest: drm_format
[930.645319] Starting dynamic subtest: drm_test_format_block_width_invalid
[930.788461] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.141s)
[930.804043] Starting dynamic subtest: drm_test_format_block_width_one_plane
[930.947298] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.156s)
[930.957141] Starting dynamic subtest: drm_test_format_block_width_two_plane
[931.103397] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.156s)
[931.115934] Starting dynamic subtest: drm_test_format_block_width_three_plane
[931.240397] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.134s)
[931.252015] Starting dynamic subtest: drm_test_format_block_width_tiled
[931.391420] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.150s)
[931.402623] Starting dynamic subtest: drm_test_format_block_height_invalid
[931.528022] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.136s)
[931.538929] Starting dynamic subtest: drm_test_format_block_height_one_plane
[931.679235] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.150s)
[931.689200] Starting dynamic subtest: drm_test_format_block_height_two_plane
[931.821971] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.142s)
[931.832410] Starting dynamic subtest: drm_test_format_block_height_three_plane
[931.965290] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.142s)
[931.975311] Starting dynamic subtest: drm_test_format_block_height_tiled
[932.124027] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.158s)
[932.134402] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[932.268396] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.142s)
[932.278058] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[932.402311] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.133s)
[932.412381] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[932.544361] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.140s)
[932.554614] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[932.678189] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.133s)
[932.688210] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[932.827360] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.146s)
[932.840215] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[932.961245] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.132s)
[932.973690] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[933.120546] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.158s)
[933.131411] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[933.259731] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.139s)
[933.262377] Subtest drm_format: SUCCESS (2.650s)
[933.482929] [132/133] ( 90s left) gem_exec_balancer (full-late-pulse)
[933.548996] Starting subtest: full-late-pulse
[938.032575] Subtest full-late-pulse: SUCCESS (4.483s)
[938.382780] [133/133] ( 85s left) kms_vblank (wait-idle)
[938.486922] Starting subtest: wait-idle
[938.489143] Starting dynamic subtest: pipe-A-eDP-1
[940.253130] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[940.269313] Starting dynamic subtest: pipe-D-eDP-1
[942.725810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.472s)
[942.728585] Subtest wait-idle: SUCCESS (4.240s)
[943.564691] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_mmap
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_fbcon_fbt
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_content_protection
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: tools_test
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: kms_atomic_transition
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_atomic_transition
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: gem_exec_create
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: kms_psr2_su
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane_alpha_blend
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: i915_selftest
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_atomic_transition
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_shared
results: parsing output: 47/ for test: gem_madvise
results: parsing output: 48/ for test: kms_psr_stress_test
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_atomic
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: prime_vgem
results: parsing output: 57/ for test: kms_chamelium_color
results: parsing output: 58/ for test: gem_exec_capture
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: prime_vgem
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gem_exec_flush
results: parsing output: 65/ for test: gem_blits
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_hdr
results: parsing output: 68/ for test: kms_plane_multiple
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: vgem_basic
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gem_ppgtt
results: parsing output: 74/ for test: gem_compute
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_panel_fitting
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_dsc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: device_reset
results: parsing output: 92/ for test: gem_vm_create
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_whisper
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_invalid_mode
results: parsing output: 104/ for test: gem_exec_basic
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_chamelium_edid
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: i915_hangman
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_ctx_shared
results: parsing output: 118/ for test: drm_read
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: gem_close
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_flink_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_selftest
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_vblank
Done.