[57.729117] Initializing watchdogs
[57.729166]   /dev/watchdog0
[57.743617] [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]
[57.747838] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.750610] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.754087] [001/155] (960s left) kms_addfb_basic (unused-modifier)
[57.834826] Starting subtest: unused-modifier
[57.837080] Subtest unused-modifier: SUCCESS (0.000s)
[57.991073] [002/155] (960s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[58.161777] Starting subtest: dp-mst-type-1-suspend-resume
[58.166323] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[58.293979] [003/155] (960s left) gem_ctx_shared (q-in-order)
[58.354860] Starting subtest: Q-in-order
[58.357301] Starting dynamic subtest: rcs0
[58.473773] Dynamic subtest rcs0: SUCCESS (0.119s)
[58.491182] Starting dynamic subtest: vcs0
[58.553616] Dynamic subtest vcs0: SUCCESS (0.080s)
[58.567754] Starting dynamic subtest: vcs1
[58.631850] Dynamic subtest vcs1: SUCCESS (0.077s)
[58.648330] Starting dynamic subtest: vecs0
[58.705050] Dynamic subtest vecs0: SUCCESS (0.073s)
[58.718194] Starting dynamic subtest: ccs0
[58.794906] Dynamic subtest ccs0: SUCCESS (0.090s)
[58.797064] Subtest Q-in-order: SUCCESS (0.444s)
[60.382748] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[60.387041] [004/155] (957s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[60.482118] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[60.486107] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.592544] [005/155] (957s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[60.689504] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[60.691773] Starting dynamic subtest: pipe-A-eDP-1
[60.809695] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[60.820098] Starting dynamic subtest: pipe-B-eDP-1
[62.205444] Dynamic subtest pipe-B-eDP-1: SKIP (1.402s)
[62.210051] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.529s)
[63.623324] [006/155] (954s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[63.718036] Starting subtest: primary-x-tiled-reflect-x-180
[70.635639] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.937s)
[71.850914] [007/155] (946s left) perf_pmu (most-busy-check-all)
[71.893331] Starting subtest: most-busy-check-all
[71.895842] Starting dynamic subtest: rcs0
[73.276417] Dynamic subtest rcs0: SUCCESS (1.383s)
[73.289595] Starting dynamic subtest: bcs0
[75.325862] Dynamic subtest bcs0: SUCCESS (2.048s)
[75.335316] Starting dynamic subtest: vcs0
[77.308321] Dynamic subtest vcs0: SUCCESS (1.984s)
[77.320276] Starting dynamic subtest: vcs1
[79.290791] Dynamic subtest vcs1: SUCCESS (1.982s)
[79.303736] Starting dynamic subtest: vecs0
[81.274905] Dynamic subtest vecs0: SUCCESS (1.984s)
[81.284755] Starting dynamic subtest: ccs0
[83.259740] Dynamic subtest ccs0: SUCCESS (1.984s)
[83.262671] Subtest most-busy-check-all: SUCCESS (11.374s)
[83.379529] [008/155] (935s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[83.485587] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[83.489790] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[83.582169] [009/155] (934s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[83.650203] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[83.759931] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[83.834668] [010/155] (934s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[83.940510] Starting subtest: yf-tiled-64bpp-rotate-180
[83.944930] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[84.040713] [011/155] (934s left) i915_pm_rc6_residency (rc6-accuracy)
[84.110846] Starting subtest: rc6-accuracy
[84.113079] Starting dynamic subtest: gt0
[87.283478] Dynamic subtest gt0: SUCCESS (3.171s)
[87.292054] Starting dynamic subtest: gt1
[90.455976] Dynamic subtest gt1: SUCCESS (3.171s)
[90.458769] Subtest rc6-accuracy: SUCCESS (6.345s)
[90.530399] [012/155] (928s left) api_intel_allocator (gem-pool)
[90.589751] Starting subtest: gem-pool
[90.601315] Subtest gem-pool: SUCCESS (0.012s)
[90.705168] [013/155] (928s left) api_intel_bb (purge-bb)
[90.759834] Starting subtest: purge-bb
[90.761793] Subtest purge-bb: SUCCESS (0.004s)
[90.893352] [014/155] (927s left) gem_ctx_param (invalid-ctx-set)
[90.952700] Starting subtest: invalid-ctx-set
[90.955027] Subtest invalid-ctx-set: SUCCESS (0.001s)
[91.063401] [015/155] (927s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[91.164726] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[91.169264] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[91.257177] [016/155] (927s left) syncobj_wait (invalid-reset-bad-pad)
[91.302598] Starting subtest: invalid-reset-bad-pad
[91.304703] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[91.396511] [017/155] (927s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[91.486219] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[91.489945] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[91.562440] [018/155] (927s left) syncobj_timeline (multi-wait-all-available-submitted)
[91.615132] Starting subtest: multi-wait-all-available-submitted
[91.617591] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[91.707820] [019/155] (927s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[91.815048] Starting subtest: cursorB-vs-flipB-atomic
[91.819056] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[91.955598] [020/155] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[92.054659] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[99.076667] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.029s)
[99.225505] [021/155] (919s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[99.326618] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[99.330754] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[99.415977] [022/155] (919s left) gem_exec_fence (syncobj-timeline-unused-fence)
[99.968737] Starting subtest: syncobj-timeline-unused-fence
[99.974071] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[101.362107] [023/155] (917s left) kms_chamelium_edid (hdmi-edid-read)
[101.742239] Subtest hdmi-edid-read: SKIP (0.000s)
[102.581401] [024/155] (916s left) kms_psr (psr2-primary-page-flip)
[102.678411] Starting subtest: psr2-primary-page-flip
[102.680920] Starting dynamic subtest: eDP-1
[104.389441] Dynamic subtest eDP-1: SUCCESS (1.713s)
[104.391795] Subtest psr2-primary-page-flip: SUCCESS (1.714s)
[105.257617] [025/155] (913s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[105.346895] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[105.351122] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[105.447896] [026/155] (913s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[105.546138] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[105.550110] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[105.667757] [027/155] (913s left) gem_create (create-ext-cpu-access-sanity-check)
[105.841960] Starting subtest: create-ext-cpu-access-sanity-check
[105.846563] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[105.914699] [028/155] (913s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[106.018362] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[106.020767] Starting dynamic subtest: pipe-A-eDP-1
[106.046904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.057573] Starting dynamic subtest: pipe-B-eDP-1
[106.081951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.090171] Starting dynamic subtest: pipe-C-eDP-1
[106.114306] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.122610] Starting dynamic subtest: pipe-D-eDP-1
[106.147065] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.151231] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[108.322632] [029/155] (911s left) kms_plane_multiple (tiling-4)
[108.415025] Starting subtest: tiling-4
[108.416884] Starting dynamic subtest: pipe-A-eDP-1
[112.336680] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.923s)
[112.346503] Starting dynamic subtest: pipe-B-eDP-1
[116.907053] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.570s)
[116.916674] Starting dynamic subtest: pipe-C-eDP-1
[121.260245] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.351s)
[121.270224] Starting dynamic subtest: pipe-D-eDP-1
[125.751921] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.490s)
[125.754234] Subtest tiling-4: SUCCESS (17.337s)
[126.557448] [030/155] (892s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[126.623172] Subtest tiled-to-tiled: SKIP (0.000s)
[126.701924] [031/155] (892s left) gem_mmap_gtt (basic-write)
[126.768682] Subtest basic-write: SKIP (0.000s)
[126.834729] [032/155] (892s left) kms_plane_scaling (invalid-num-scalers)
[126.924118] Starting subtest: invalid-num-scalers
[126.926458] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[126.940129] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[126.948939] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[126.972853] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[126.981615] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[127.002655] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[127.011046] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[127.034429] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[127.036626] Subtest invalid-num-scalers: SUCCESS (0.112s)
[127.137767] [033/155] (892s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[127.260441] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[127.265054] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[127.404308] [034/155] (892s left) vgem_basic (debugfs)
[127.445713] Starting subtest: debugfs
[127.447630] Subtest debugfs: SUCCESS (0.000s)
[127.512201] [035/155] (892s left) kms_cursor_crc (cursor-sliding-64x64)
[127.675615] Starting subtest: cursor-sliding-64x64
[127.680117] Starting dynamic subtest: pipe-A-eDP-1
[130.930429] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.248s)
[130.956517] Starting dynamic subtest: pipe-D-eDP-1
[134.836735] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.888s)
[134.839552] Subtest cursor-sliding-64x64: SUCCESS (7.162s)
[135.714415] [036/155] (883s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[135.763739] Starting subtest: wait-all-for-submit-delayed-submit
[135.866879] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[135.942303] [037/155] (883s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[136.039329] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[136.125842] [038/155] (883s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[136.182598] Starting subtest: etime-single-wait-all-available-unsubmitted
[136.287185] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[136.365426] [039/155] (883s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[136.458913] Starting subtest: plane-upscale-factor-0-25-with-rotation
[136.461232] Starting dynamic subtest: pipe-A
[136.683419] Dynamic subtest pipe-A: SUCCESS (0.227s)
[136.692877] Starting dynamic subtest: pipe-B
[138.001901] Dynamic subtest pipe-B: SUCCESS (1.317s)
[138.010522] Starting dynamic subtest: pipe-C
[139.333443] Dynamic subtest pipe-C: SUCCESS (1.332s)
[139.343149] Starting dynamic subtest: pipe-D
[140.673095] Dynamic subtest pipe-D: SUCCESS (1.339s)
[140.675308] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.217s)
[141.846297] [040/155] (877s left) kms_sequence (get-forked-busy)
[141.945159] Starting subtest: get-forked-busy
[141.947448] Starting dynamic subtest: pipe-A-eDP-1
[143.886385] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[143.895252] Starting dynamic subtest: pipe-B-eDP-1
[146.522282] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.634s)
[146.533063] Starting dynamic subtest: pipe-C-eDP-1
[149.151618] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.628s)
[149.160244] Starting dynamic subtest: pipe-D-eDP-1
[151.785218] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s)
[151.787557] Subtest get-forked-busy: SUCCESS (9.841s)
[152.668202] [041/155] (867s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[152.780285] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[152.784585] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[152.873303] [042/155] (867s left) kms_getfb (getfb-handle-protection)
[152.971153] Starting subtest: getfb-handle-protection
[152.997255] Subtest getfb-handle-protection: SUCCESS (0.027s)
[153.120600] [043/155] (866s left) perf (polling)
[153.244226] Starting subtest: polling
[153.246415] Starting dynamic subtest: 0-rcs0
[163.273572] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[163.282883] Starting dynamic subtest: 1-vcs0
[173.346658] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[173.349176] Subtest polling: SUCCESS (20.048s)
[173.387804] [044/155] (846s left) gem_tiling_max_stride
[173.515684] [045/155] (846s left) kms_dp_link_training (uhbr-mst)
[173.614032] Starting subtest: uhbr-mst
[173.622282] Subtest uhbr-mst: SKIP (0.000s)
[173.684340] [046/155] (846s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[173.780902] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[173.784961] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[173.862340] [047/155] (846s left) gem_mmap_wc (fault-concurrent)
[173.915626] Subtest fault-concurrent: SKIP (0.000s)
[173.976090] [048/155] (846s left) kms_fb_coherency (memset-crc)
[174.076191] Starting subtest: memset-crc
[174.078501] Starting dynamic subtest: mmap-offset-wc
[174.438375] Dynamic subtest mmap-offset-wc: SUCCESS (0.364s)
[174.728727] Starting dynamic subtest: mmap-offset-uc
[180.869198] Dynamic subtest mmap-offset-uc: SUCCESS (6.149s)
[181.168895] Subtest memset-crc: SUCCESS (7.092s)
[182.044972] [049/155] (838s left) gem_softpin (noreloc-s3)
[182.104613] Starting subtest: noreloc-S3
[202.886928] Subtest noreloc-S3: SUCCESS (5.414s)
[202.997881] [050/155] (817s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[203.121734] Starting subtest: fbcpsrhdr-modesetfrombusy
[203.126637] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[203.209358] [051/155] (817s left) kms_selftest (drm_dp_mst_helper)
[203.243626] Starting subtest: drm_dp_mst_helper
[203.285903] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[203.380042] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.094s)
[203.390056] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[203.479147] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.098s)
[203.488355] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[203.585894] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.108s)
[203.588244] Subtest drm_dp_mst_helper: SUCCESS (0.345s)
[203.726524] [052/155] (816s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[203.820275] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[207.927726] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.148s)
[209.094035] [053/155] (811s left) i915_hangman (detector)
[209.164007] Starting subtest: detector
[209.166433] Starting dynamic subtest: rcs0
[219.670053] Dynamic subtest rcs0: SUCCESS (10.539s)
[219.684204] Starting dynamic subtest: bcs0
[231.702771] Dynamic subtest bcs0: SUCCESS (12.038s)
[231.715627] Starting dynamic subtest: vcs0
[243.606197] Dynamic subtest vcs0: SUCCESS (11.899s)
[243.619586] Starting dynamic subtest: vcs1
[254.613706] Dynamic subtest vcs1: SUCCESS (11.006s)
[254.628711] Starting dynamic subtest: vecs0
[265.621043] Dynamic subtest vecs0: SUCCESS (11.007s)
[265.633924] Starting dynamic subtest: ccs0
[276.694746] Dynamic subtest ccs0: SUCCESS (11.074s)
[276.697848] Subtest detector: SUCCESS (67.581s)
[276.780957] [054/155] (743s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[276.901005] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[276.903568] Starting dynamic subtest: pipe-A-eDP-1
[276.930305] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[276.940078] Starting dynamic subtest: pipe-B-eDP-1
[276.968031] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[276.977380] Starting dynamic subtest: pipe-C-eDP-1
[277.004964] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[277.014142] Starting dynamic subtest: pipe-D-eDP-1
[277.043516] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[277.048840] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[279.189505] [055/155] (741s left) gem_exec_fence (expired-history)
[279.589316] Starting subtest: expired-history
[286.388000] Subtest expired-history: SUCCESS (6.802s)
[286.980701] [056/155] (733s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[287.080075] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[287.084933] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[287.191010] [057/155] (733s left) kms_big_fb (linear-64bpp-rotate-270)
[287.283875] Starting subtest: linear-64bpp-rotate-270
[287.304478] Subtest linear-64bpp-rotate-270: SKIP (0.020s)
[287.406638] [058/155] (733s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[287.511479] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[287.515969] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[287.598388] [059/155] (733s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[287.688508] Starting subtest: flip-vs-dpms-on-nop-interruptible
[287.690897] Starting dynamic subtest: A-eDP1
[289.573059] Dynamic subtest A-eDP1: SUCCESS (1.885s)
[289.587313] Starting dynamic subtest: B-eDP1
[291.425021] Dynamic subtest B-eDP1: SUCCESS (1.849s)
[291.438379] Starting dynamic subtest: C-eDP1
[293.245555] Dynamic subtest C-eDP1: SUCCESS (1.820s)
[293.258897] Starting dynamic subtest: D-eDP1
[295.062247] Dynamic subtest D-eDP1: SUCCESS (1.813s)
[295.069851] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.381s)
[296.273479] [060/155] (724s left) kms_pm_rpm (pc8-residency)
[297.800615] Starting subtest: pc8-residency
[297.806354] Subtest pc8-residency: SKIP (0.000s)
[298.586820] [061/155] (722s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[298.678018] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[298.680579] Starting dynamic subtest: pipe-A-eDP-1
[315.088127] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.360s)
[315.098051] Starting dynamic subtest: pipe-B-eDP-1
[332.089106] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.512s)
[332.099354] Starting dynamic subtest: pipe-C-eDP-1
[349.036826] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.402s)
[349.047636] Starting dynamic subtest: pipe-D-eDP-1
[366.036291] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.385s)
[366.038490] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.663s)
[367.277989] [062/155] (653s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[367.381964] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[367.386045] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.489360] [063/155] (653s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[367.581366] Starting subtest: psr-rgb565-draw-blt
[374.653844] Subtest psr-rgb565-draw-blt: SUCCESS (7.146s)
[374.776197] [064/155] (646s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[374.888901] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[374.891056] Starting dynamic subtest: A-eDP1
[383.743886] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[383.753887] Starting dynamic subtest: B-eDP1
[392.665070] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[392.676392] Starting dynamic subtest: C-eDP1
[401.631350] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[401.644475] Starting dynamic subtest: D-eDP1
[410.562643] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[410.565178] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.679s)
[411.735852] [065/155] (609s left) gem_request_retire (retire-vma-not-inactive)
[411.804944] Starting subtest: retire-vma-not-inactive
[411.867402] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[411.984141] [066/155] (608s left) gen9_exec_parse (valid-registers)
[412.042451] Subtest valid-registers: SKIP (0.000s)
[412.107907] [067/155] (608s left) syncobj_wait (single-wait-for-submit-signaled)
[412.161459] Starting subtest: single-wait-for-submit-signaled
[412.163382] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[412.250438] [068/155] (608s left) gem_exec_params (invalid-ring)
[412.308393] Starting subtest: invalid-ring
[412.310724] Subtest invalid-ring: SUCCESS (0.000s)
[412.412213] [069/155] (608s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[412.509634] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[412.513906] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[412.609529] [070/155] (608s left) core_setmaster (master-drop-set-shared-fd)
[412.687710] Starting subtest: master-drop-set-shared-fd
[412.709405] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[412.749036] [071/155] (608s left) gem_exec_balancer (noheartbeat)
[413.005665] Starting subtest: noheartbeat
[413.010283] Subtest noheartbeat: SKIP (0.000s)
[413.109432] [072/155] (608s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[413.205286] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[413.209615] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[413.302673] [073/155] (607s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[413.403025] Starting subtest: y-tiled-8bpp-rotate-270
[413.407114] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[413.509110] [074/155] (607s left) kms_frontbuffer_tracking (fbchdr-stridechange)
[413.617478] Starting subtest: fbchdr-stridechange
[413.621688] Subtest fbchdr-stridechange: SKIP (0.000s)
[413.738859] [075/155] (607s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[413.834869] Starting subtest: modeset-transition-nonblocking-fencing
[413.836823] Starting dynamic subtest: 1x-outputs
[425.206494] Dynamic subtest 1x-outputs: SUCCESS (11.366s)
[425.209470] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.368s)
[426.073894] [076/155] (595s left) gem_exec_schedule (in-order)
[426.141673] Starting subtest: in-order
[426.143526] Starting dynamic subtest: rcs0
[426.235853] Dynamic subtest rcs0: SUCCESS (0.102s)
[426.248225] Starting dynamic subtest: vcs0
[426.317331] Dynamic subtest vcs0: SUCCESS (0.080s)
[426.333946] Starting dynamic subtest: vcs1
[426.395235] Dynamic subtest vcs1: SUCCESS (0.077s)
[426.409334] Starting dynamic subtest: vecs0
[426.473034] Dynamic subtest vecs0: SUCCESS (0.076s)
[426.487437] Starting dynamic subtest: ccs0
[426.565343] Dynamic subtest ccs0: SUCCESS (0.092s)
[426.567884] Subtest in-order: SUCCESS (0.432s)
[427.591296] [077/155] (593s left) gem_exec_reloc (basic-write-wc-noreloc)
[427.653112] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[427.736637] [078/155] (593s left) kms_plane (pixel-format-x-tiled-modifier)
[427.831026] Starting subtest: pixel-format-x-tiled-modifier
[427.856912] Starting dynamic subtest: pipe-A-plane-0
[428.223675] Dynamic subtest pipe-A-plane-0: SUCCESS (0.366s)
[428.235111] Starting dynamic subtest: pipe-A-plane-3
[428.523779] Dynamic subtest pipe-A-plane-3: SUCCESS (0.298s)
[428.533373] Starting dynamic subtest: pipe-A-plane-5
[428.536902] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[429.656428] Starting dynamic subtest: pipe-B-plane-0
[430.045543] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[430.056147] Starting dynamic subtest: pipe-B-plane-3
[430.378912] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[430.389246] Starting dynamic subtest: pipe-B-plane-5
[430.393837] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[430.689737] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.861s)
[431.539295] [079/155] (589s left) i915_query (query-regions-sanity-check)
[431.591916] Starting subtest: query-regions-sanity-check
[431.605960] Subtest query-regions-sanity-check: SUCCESS (0.015s)
[431.752365] [080/155] (589s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[431.846873] Starting subtest: stress-xrgb8888-yftiled
[431.851422] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[431.914605] [081/155] (589s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[432.016898] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[432.020872] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[432.142766] [082/155] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[432.247523] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[432.251720] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[432.359174] [083/155] (589s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render)
[432.459328] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render
[432.463095] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[432.553206] [084/155] (589s left) gem_softpin (safe-alignment)
[432.613616] Starting subtest: safe-alignment
[432.636139] Subtest safe-alignment: SUCCESS (0.023s)
[434.565266] [085/155] (587s left) kms_fbcon_fbt (psr)
[434.624671] Starting subtest: psr
[442.066358] Subtest psr: SUCCESS (7.439s)
[442.140719] [086/155] (579s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[442.693832] Starting subtest: syncobj-stationary-timeline-chain-engines
[442.797607] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.105s)
[444.624870] [087/155] (577s left) kms_psr (fbc-psr2-sprite-render)
[444.713558] Starting subtest: fbc-psr2-sprite-render
[444.715886] Starting dynamic subtest: eDP-1
[444.719915] Dynamic subtest eDP-1: SKIP (0.000s)
[444.723959] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[444.791004] [088/155] (577s left) gem_ctx_persistence (userptr)
[444.857502] Starting subtest: userptr
[445.010243] Subtest userptr: SUCCESS (0.155s)
[445.115784] [089/155] (576s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[445.209384] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[445.213408] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[445.311132] [090/155] (576s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move)
[445.410329] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move
[445.414810] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[445.516531] [091/155] (576s left) gem_lmem_swapping (parallel-multi)
[445.555388] Subtest parallel-multi: SKIP (0.000s)
[445.598124] [092/155] (576s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[445.667331] Starting subtest: yf-tiled-ccs-to-yf-tiled
[445.670781] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[445.849557] [093/155] (576s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[445.938887] Starting subtest: bad-rotation-90-y-tiled-ccs
[445.941275] Starting dynamic subtest: pipe-A-eDP-1
[445.964289] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[445.977029] Starting dynamic subtest: pipe-B-eDP-1
[445.998236] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[446.007982] Starting dynamic subtest: pipe-C-eDP-1
[446.028751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[446.038203] Starting dynamic subtest: pipe-D-eDP-1
[446.059793] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[446.064037] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[448.264840] [094/155] (573s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[448.360504] Starting subtest: yf-tiled-16bpp-rotate-90
[448.365053] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[448.469429] [095/155] (573s left) kms_flip (dpms-off-confusion)
[448.552447] Starting subtest: dpms-off-confusion
[448.554754] Starting dynamic subtest: A-eDP1
[457.303894] Dynamic subtest A-eDP1: SUCCESS (8.720s)
[457.316282] Starting dynamic subtest: B-eDP1
[466.024976] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[466.038330] Starting dynamic subtest: C-eDP1
[474.749270] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[474.761711] Starting dynamic subtest: D-eDP1
[483.382533] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[483.385366] Subtest dpms-off-confusion: SUCCESS (34.794s)
[484.511393] [096/155] (537s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[484.613658] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[484.618078] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[484.701469] [097/155] (537s left) gem_pxp (fail-invalid-protected-context)
[484.815338] Starting subtest: fail-invalid-protected-context
[484.817813] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[484.932776] [098/155] (537s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[485.045674] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[494.484435] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.438s)
[495.361656] [099/155] (526s left) kms_invalid_mode (zero-hdisplay)
[495.459100] Starting subtest: zero-hdisplay
[495.461369] Starting dynamic subtest: pipe-A-eDP-1
[495.744280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[495.755514] Starting dynamic subtest: pipe-B-eDP-1
[495.757862] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[495.767978] Starting dynamic subtest: pipe-C-eDP-1
[495.769903] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[495.779230] Starting dynamic subtest: pipe-D-eDP-1
[495.781623] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[495.784036] Subtest zero-hdisplay: SUCCESS (0.292s)
[496.591803] [100/155] (525s left) gem_watchdog (default-physical)
[496.665145] Starting subtest: default-physical
[498.429853] Subtest default-physical: SUCCESS (1.772s)
[498.530662] [101/155] (523s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[498.582345] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[498.584694] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[498.704117] [102/155] (523s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[498.795538] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[498.799964] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[498.893809] [103/155] (523s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-blt)
[498.990165] Starting subtest: psrhdr-rgb101010-draw-blt
[498.994704] Subtest psrhdr-rgb101010-draw-blt: SKIP (0.000s)
[499.087105] [104/155] (523s left) gen9_exec_parse (batch-without-end)
[499.150043] Subtest batch-without-end: SKIP (0.000s)
[499.228528] [105/155] (523s left) kms_pm_dc (dc9-dpms)
[500.332680] Starting subtest: dc9-dpms
[501.779060] Subtest dc9-dpms: SUCCESS (1.445s)
[501.854735] [106/155] (520s left) syncobj_basic (bad-fd-to-handle)
[501.902452] Starting subtest: bad-fd-to-handle
[501.904322] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[502.032494] [107/155] (520s left) gem_exec_flush (basic-wb-prw-default)
[502.094811] Starting subtest: basic-wb-prw-default
[507.586875] Subtest basic-wb-prw-default: SUCCESS (5.467s)
[507.751529] [108/155] (514s left) gem_mmap_gtt (medium-copy)
[507.808898] Subtest medium-copy: SKIP (0.000s)
[507.874712] [109/155] (514s left) perf (non-sampling-read-error)
[507.987320] Starting subtest: non-sampling-read-error
[507.998434] Subtest non-sampling-read-error: SUCCESS (0.008s)
[508.043308] [110/155] (514s left) gem_mmap_offset (perf)
[508.102083] Starting subtest: perf
[508.104268] Starting dynamic subtest: smem0
[508.474891] Dynamic subtest smem0: SUCCESS (0.369s)
[508.477532] Subtest perf: SUCCESS (0.370s)
[508.601589] [111/155] (514s left) vgem_basic (bad-handle)
[508.648310] Starting subtest: bad-handle
[508.650372] Subtest bad-handle: SUCCESS (0.000s)
[508.725830] [112/155] (514s left) kms_chamelium_hpd (dp-hpd-storm)
[509.118288] Subtest dp-hpd-storm: SKIP (0.000s)
[509.925062] [113/155] (513s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[510.034262] Starting subtest: x-tiled-16bpp-rotate-0
[511.223528] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.189s)
[511.338939] [114/155] (511s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[511.439306] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[511.442851] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[511.527782] [115/155] (511s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[511.619770] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[516.384118] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.768s)
[516.499897] [116/155] (506s left) kms_rotation_crc (exhaust-fences)
[516.592690] Starting subtest: exhaust-fences
[516.596851] Subtest exhaust-fences: SKIP (0.000s)
[516.666859] [117/155] (506s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[516.759805] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[516.763898] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[516.856986] [118/155] (506s left) kms_psr2_su (page_flip-p010)
[516.916994] Subtest page_flip-P010: SKIP (0.000s)
[516.979352] [119/155] (506s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[517.083440] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[517.087893] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[517.170912] [120/155] (506s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[517.260919] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[517.264970] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[517.357318] [121/155] (505s left) perf_pmu (busy-accuracy-2)
[517.400012] Starting subtest: busy-accuracy-2
[517.401940] Starting dynamic subtest: rcs0
[520.448104] Dynamic subtest rcs0: SUCCESS (3.044s)
[520.459474] Starting dynamic subtest: bcs0
[523.562178] Dynamic subtest bcs0: SUCCESS (3.062s)
[523.572842] Starting dynamic subtest: vcs0
[526.605440] Dynamic subtest vcs0: SUCCESS (3.043s)
[526.614909] Starting dynamic subtest: vcs1
[529.659197] Dynamic subtest vcs1: SUCCESS (3.052s)
[529.670311] Starting dynamic subtest: vecs0
[532.704157] Dynamic subtest vecs0: SUCCESS (3.043s)
[532.716263] Starting dynamic subtest: ccs0
[535.766031] Dynamic subtest ccs0: SUCCESS (3.060s)
[535.768075] Subtest busy-accuracy-2: SUCCESS (18.317s)
[535.835923] [122/155] (487s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[535.938286] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[535.942670] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[536.038281] [123/155] (487s left) gem_barrier_race (remote-request)
[536.093469] Starting subtest: remote-request
[536.095777] Starting dynamic subtest: rcs0
[541.239089] Dynamic subtest rcs0: SUCCESS (5.148s)
[541.241377] Subtest remote-request: SUCCESS (5.149s)
[541.378947] [124/155] (482s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[541.479745] Starting subtest: psr-2p-primscrn-cur-indfb-move
[541.483108] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[541.578455] [125/155] (481s left) syncobj_wait (invalid-signal-bad-pad)
[541.640612] Starting subtest: invalid-signal-bad-pad
[541.642650] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[541.751232] [126/155] (481s left) gem_exec_schedule (reorder-wide)
[541.930091] Subtest reorder-wide: SKIP (0.000s)
[542.109458] [127/155] (481s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[542.200674] Starting subtest: hdr-rgb565-draw-pwrite
[542.205154] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[542.310185] [128/155] (481s left) kms_lease (lease-unleased-crtc)
[542.399893] Starting subtest: lease-unleased-crtc
[542.402200] Starting dynamic subtest: pipe-A-eDP-1
[542.691840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[542.703941] Starting dynamic subtest: pipe-B-eDP-1
[543.417349] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.725s)
[543.432696] Starting dynamic subtest: pipe-C-eDP-1
[543.435064] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[543.445266] Starting dynamic subtest: pipe-D-eDP-1
[543.447429] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[543.449610] Subtest lease-unleased-crtc: SUCCESS (1.035s)
[543.803659] [129/155] (479s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[543.899668] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[543.903722] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[544.006311] [130/155] (479s left) prime_busy (hang-wait)
[544.070210] Starting subtest: hang-wait
[544.072560] Starting dynamic subtest: rcs0
[569.984746] Dynamic subtest rcs0: SUCCESS (25.907s)
[569.995879] Starting dynamic subtest: bcs0
[577.135529] Dynamic subtest bcs0: SUCCESS (7.158s)
[577.145489] Starting dynamic subtest: vcs0
[584.107962] Dynamic subtest vcs0: SUCCESS (6.971s)
[584.117922] Starting dynamic subtest: vcs1
[591.092418] Dynamic subtest vcs1: SUCCESS (6.980s)
[591.103492] Starting dynamic subtest: vecs0
[598.121324] Dynamic subtest vecs0: SUCCESS (7.032s)
[598.133320] Starting dynamic subtest: ccs0
[611.962328] Dynamic subtest ccs0: SUCCESS (13.836s)
[611.964514] Subtest hang-wait: SUCCESS (67.895s)
[612.106705] [131/155] (411s left) gem_eio (wait-wedge-immediate)
[612.294687] Starting subtest: wait-wedge-immediate
[613.603097] Subtest wait-wedge-immediate: SUCCESS (1.309s)
[613.754730] [132/155] (409s left) kms_psr (psr2-cursor-mmap-cpu)
[613.857918] Starting subtest: psr2-cursor-mmap-cpu
[613.860133] Starting dynamic subtest: eDP-1
[615.555980] Dynamic subtest eDP-1: SUCCESS (1.697s)
[615.558388] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.698s)
[616.439594] [133/155] (407s left) gem_mmap_gtt (cpuset-big-copy-odd)
[616.488496] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[616.547486] [134/155] (407s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[616.644818] Starting subtest: fbc-psr-sprite-mmap-cpu
[616.647063] Starting dynamic subtest: eDP-1
[616.651341] Dynamic subtest eDP-1: SKIP (0.000s)
[616.655607] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[616.716940] [135/155] (407s left) kms_cursor_crc (cursor-offscreen-512x170)
[617.033667] Starting subtest: cursor-offscreen-512x170
[617.037361] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[617.170419] [136/155] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[617.284811] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[617.290097] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[617.386596] [137/155] (406s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[617.485989] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[617.489515] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[617.578780] [138/155] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[617.674883] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[617.678474] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[617.788753] [139/155] (406s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[617.883755] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[621.413685] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.533s)
[622.559151] [140/155] (401s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[622.660767] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[622.665299] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[622.747247] [141/155] (401s left) gem_ctx_param (basic-default)
[622.803529] Starting subtest: basic-default
[622.805827] Subtest basic-default: SUCCESS (0.000s)
[622.878666] [142/155] (401s left) gem_exec_whisper (basic-fds)
[622.941979] Starting subtest: basic-fds
[630.724258] Subtest basic-fds: SUCCESS (7.777s)
[630.919488] [143/155] (393s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[631.022600] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[631.024958] Starting dynamic subtest: pipe-A-eDP-1
[631.139712] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[631.155781] Starting dynamic subtest: pipe-B-eDP-1
[632.327412] Dynamic subtest pipe-B-eDP-1: SKIP (1.185s)
[632.332121] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.309s)
[633.531931] [144/155] (390s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[633.592731] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[633.595024] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[633.706330] [145/155] (390s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[633.814176] Starting subtest: cursor-vs-flip-toggle
[665.092498] Subtest cursor-vs-flip-toggle: SUCCESS (31.275s)
[665.960127] [146/155] (358s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[666.064992] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[666.069476] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[666.134716] [147/155] (358s left) gem_ctx_isolation (preservation-reset)
[666.302151] Starting subtest: preservation-reset
[666.305158] Starting dynamic subtest: rcs0
[666.591897] Dynamic subtest rcs0: SUCCESS (0.291s)
[666.602520] Starting dynamic subtest: bcs0
[666.934661] Dynamic subtest bcs0: SUCCESS (0.342s)
[666.945697] Starting dynamic subtest: vcs0
[667.271556] Dynamic subtest vcs0: SUCCESS (0.336s)
[667.285922] Starting dynamic subtest: vcs1
[668.801990] Dynamic subtest vcs1: SUCCESS (1.530s)
[668.815683] Starting dynamic subtest: vecs0
[670.797683] Dynamic subtest vecs0: SUCCESS (1.995s)
[670.813757] Starting dynamic subtest: ccs0
[672.808747] Dynamic subtest ccs0: SUCCESS (2.010s)
[672.811159] Subtest preservation-reset: SUCCESS (6.509s)
[672.943707] [148/155] (351s left) kms_color (invalid-ctm-matrix-sizes)
[673.041171] Starting subtest: invalid-ctm-matrix-sizes
[673.043482] Starting dynamic subtest: pipe-A
[673.045704] Dynamic subtest pipe-A: SUCCESS (0.002s)
[673.057715] Starting dynamic subtest: pipe-B
[673.059588] Dynamic subtest pipe-B: SUCCESS (0.003s)
[673.069827] Starting dynamic subtest: pipe-C
[673.072065] Dynamic subtest pipe-C: SUCCESS (0.003s)
[673.082082] Starting dynamic subtest: pipe-D
[673.083972] Dynamic subtest pipe-D: SUCCESS (0.004s)
[673.085893] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[673.137418] [149/155] (351s left) syncobj_timeline (single-wait-available-signaled)
[673.182790] Starting subtest: single-wait-available-signaled
[673.185136] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[673.269708] [150/155] (351s left) kms_vblank (ts-continuation-suspend)
[673.362995] Starting subtest: ts-continuation-suspend
[673.365228] Starting dynamic subtest: pipe-A-eDP-1
[690.210311] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.518s)
[690.226938] Starting dynamic subtest: pipe-D-eDP-1
[707.186571] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.192s)
[707.189423] Subtest ts-continuation-suspend: SUCCESS (3.714s)
[707.996922] [151/155] (316s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[708.271369] Starting subtest: cursor-rapid-movement-512x512
[708.276377] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[708.419062] [152/155] (316s left) gem_softpin (32b-excludes-last-page)
[708.472102] Starting subtest: 32b-excludes-last-page
[708.477131] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[708.590390] [153/155] (316s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[708.679514] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[708.682035] Starting dynamic subtest: pipe-A-eDP-1
[708.706394] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[708.717267] Starting dynamic subtest: pipe-B-eDP-1
[708.743414] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[708.753695] Starting dynamic subtest: pipe-C-eDP-1
[708.778506] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[708.788816] Starting dynamic subtest: pipe-D-eDP-1
[708.814561] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[708.819424] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[710.929580] [154/155] (313s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[711.028496] Starting subtest: 4-tiled-32bpp-rotate-0
[712.372493] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.359s)
[712.546217] [155/155] (312s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[712.656834] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[712.660992] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[712.749072] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: gem_ctx_shared
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: i915_pm_rc6_residency
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_create
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: gem_set_tiling_vs_blt
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: vgem_basic
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: kms_sequence
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_getfb
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_tiling_max_stride
results: parsing output: 44/ for test: kms_dp_link_training
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: kms_fb_coherency
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_selftest
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: i915_hangman
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_request_retire
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: core_setmaster
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: i915_query
results: parsing output: 79/ for test: kms_pipe_stress
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_fbcon_fbt
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_invalid_mode
results: parsing output: 99/ for test: gem_watchdog
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gen9_exec_parse
results: parsing output: 104/ for test: kms_pm_dc
results: parsing output: 105/ for test: syncobj_basic
results: parsing output: 106/ for test: gem_exec_flush
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: vgem_basic
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr2_su
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_barrier_race
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_lease
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: prime_busy
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: gem_mmap_gtt
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: kms_cursor_crc
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_ctx_param
results: parsing output: 141/ for test: gem_exec_whisper
results: parsing output: 142/ for test: kms_psr2_sf
results: parsing output: 143/ for test: syncobj_wait
results: parsing output: 144/ for test: kms_cursor_legacy
results: parsing output: 145/ for test: kms_flip_scaled_crc
results: parsing output: 146/ for test: gem_ctx_isolation
results: parsing output: 147/ for test: kms_color
results: parsing output: 148/ for test: syncobj_timeline
results: parsing output: 149/ for test: kms_vblank
results: parsing output: 150/ for test: kms_cursor_crc
results: parsing output: 151/ for test: gem_softpin
results: parsing output: 152/ for test: kms_ccs
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.