[54.289638] Initializing watchdogs [54.289772] /dev/watchdog0 [54.305250] [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] [54.309707] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.314465] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [54.317978] [001/131] (960s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [54.447700] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [54.450153] Starting dynamic subtest: pipe-A-default-mode [54.778976] Dynamic subtest pipe-A-default-mode: SKIP (0.327s) [54.783841] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.328s) [55.581734] [002/131] (959s left) kms_feature_discovery (psr2) [55.682436] Starting subtest: psr2 [55.684655] Subtest psr2: SUCCESS (0.000s) [55.753217] [003/131] (959s left) gem_ctx_shared (q-promotion) [55.809367] Starting subtest: Q-promotion [55.811967] Starting dynamic subtest: rcs0 [55.930471] Dynamic subtest rcs0: SUCCESS (0.120s) [55.943394] Starting dynamic subtest: vcs0 [56.007952] Dynamic subtest vcs0: SUCCESS (0.077s) [56.022997] Starting dynamic subtest: vcs1 [56.088003] Dynamic subtest vcs1: SUCCESS (0.079s) [56.103102] Starting dynamic subtest: vecs0 [56.161072] Dynamic subtest vecs0: SUCCESS (0.071s) [56.176626] Starting dynamic subtest: ccs0 [56.230086] Dynamic subtest ccs0: SUCCESS (0.070s) [56.233103] Subtest Q-promotion: SUCCESS (0.417s) [57.987680] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true [57.990890] [004/131] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [58.094778] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [58.099090] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [58.199599] [005/131] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [58.303748] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [65.580909] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.248s) [65.725874] [006/131] (949s left) vgem_basic (dmabuf-export) [65.768217] Starting subtest: dmabuf-export [65.800291] Subtest dmabuf-export: SUCCESS (0.034s) [65.903491] [007/131] (949s left) kms_joiner (basic-force-ultra-joiner) [66.001482] Starting subtest: basic-force-ultra-joiner [66.005979] Subtest basic-force-ultra-joiner: SKIP (0.000s) [66.064019] [008/131] (949s left) gem_ctx_isolation (preservation-reset) [66.229407] Starting subtest: preservation-reset [66.232210] Starting dynamic subtest: rcs0 [66.488162] Dynamic subtest rcs0: SUCCESS (0.260s) [66.495843] Starting dynamic subtest: bcs0 [66.799670] Dynamic subtest bcs0: SUCCESS (0.311s) [66.807075] Starting dynamic subtest: vcs0 [67.131587] Dynamic subtest vcs0: SUCCESS (0.331s) [67.141769] Starting dynamic subtest: vcs1 [69.195491] Dynamic subtest vcs1: SUCCESS (2.060s) [69.202964] Starting dynamic subtest: vecs0 [71.304664] Dynamic subtest vecs0: SUCCESS (2.106s) [71.315554] Starting dynamic subtest: ccs0 [73.230667] Dynamic subtest ccs0: SUCCESS (1.924s) [73.233117] Subtest preservation-reset: SUCCESS (6.995s) [73.385922] [009/131] (941s left) i915_query (query-regions-garbage-items) [73.442627] Starting subtest: query-regions-garbage-items [73.444968] Subtest query-regions-garbage-items: SUCCESS (0.000s) [73.562718] [010/131] (941s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [73.663467] Starting subtest: psr-rgb565-draw-pwrite [80.638735] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.973s) [80.770660] [011/131] (934s left) perf_pmu (busy-idle-no-semaphores) [80.809021] Starting subtest: busy-idle-no-semaphores [80.811523] Starting dynamic subtest: rcs0 [81.489876] Dynamic subtest rcs0: SUCCESS (0.679s) [81.498829] Starting dynamic subtest: bcs0 [82.141673] Dynamic subtest bcs0: SUCCESS (0.650s) [82.155230] Starting dynamic subtest: vcs0 [82.793232] Dynamic subtest vcs0: SUCCESS (0.651s) [82.804753] Starting dynamic subtest: vcs1 [84.540474] Dynamic subtest vcs1: SUCCESS (1.747s) [84.551959] Starting dynamic subtest: vecs0 [86.524870] Dynamic subtest vecs0: SUCCESS (1.983s) [86.534449] Starting dynamic subtest: ccs0 [88.510589] Dynamic subtest ccs0: SUCCESS (1.985s) [88.512991] Subtest busy-idle-no-semaphores: SUCCESS (7.697s) [88.626936] [012/131] (926s left) kms_flip (basic-flip-vs-dpms) [88.728955] Starting subtest: basic-flip-vs-dpms [88.731550] Starting dynamic subtest: A-eDP1 [91.308871] Dynamic subtest A-eDP1: SUCCESS (2.578s) [91.317704] Starting dynamic subtest: B-eDP1 [93.490480] Dynamic subtest B-eDP1: SUCCESS (2.183s) [93.499860] Starting dynamic subtest: C-eDP1 [95.582590] Dynamic subtest C-eDP1: SUCCESS (2.088s) [95.592166] Starting dynamic subtest: D-eDP1 [97.661867] Dynamic subtest D-eDP1: SUCCESS (2.079s) [97.664190] Subtest basic-flip-vs-dpms: SUCCESS (8.933s) [98.456021] [013/131] (916s left) gem_exec_balancer (hang) [98.721969] Starting subtest: hang [100.348218] Subtest hang: SUCCESS (1.628s) [100.486190] [014/131] (914s left) gem_mmap_gtt (zero-extend) [100.546656] Subtest zero-extend: SKIP (0.000s) [100.608441] [015/131] (914s left) gem_lmem_swapping (parallel-random) [100.642626] Subtest parallel-random: SKIP (0.000s) [100.684913] [016/131] (914s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [100.807838] Starting subtest: short-flip-before-cursor-toggle [101.732662] Subtest short-flip-before-cursor-toggle: SUCCESS (0.926s) [102.580909] [017/131] (912s left) syncobj_wait (multi-wait-all-for-submit-signaled) [102.642162] Starting subtest: multi-wait-all-for-submit-signaled [102.644130] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [102.737609] [018/131] (912s left) kms_flip (flip-vs-absolute-wf_vblank) [102.832811] Starting subtest: flip-vs-absolute-wf_vblank [102.835097] Starting dynamic subtest: A-eDP1 [111.734624] Dynamic subtest A-eDP1: SUCCESS (8.901s) [111.743810] Starting dynamic subtest: B-eDP1 [120.669030] Dynamic subtest B-eDP1: SUCCESS (8.933s) [120.676838] Starting dynamic subtest: C-eDP1 [129.643074] Dynamic subtest C-eDP1: SUCCESS (8.926s) [129.653186] Starting dynamic subtest: D-eDP1 [138.535504] Dynamic subtest D-eDP1: SUCCESS (8.937s) [138.540588] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.706s) [139.756625] [019/131] (875s left) gem_ppgtt (flink-and-close-vma-leak) [139.823914] Starting subtest: flink-and-close-vma-leak [139.865740] Subtest flink-and-close-vma-leak: SUCCESS (0.041s) [139.984902] [020/131] (875s left) gem_exec_fence (basic-wait-all) [140.048348] Starting subtest: basic-wait-all [140.154546] Subtest basic-wait-all: SUCCESS (0.109s) [141.992680] [021/131] (873s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [142.078136] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [142.089628] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s) [142.168820] [022/131] (873s left) kms_big_fb (y-tiled-64bpp-rotate-0) [142.275051] Starting subtest: y-tiled-64bpp-rotate-0 [142.279461] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [142.371816] [023/131] (873s left) kms_big_fb (4-tiled-8bpp-rotate-180) [142.472862] Starting subtest: 4-tiled-8bpp-rotate-180 [143.598594] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.126s) [143.742792] [024/131] (871s left) kms_chamelium_color (ctm-blue-to-red) [143.829296] Subtest ctm-blue-to-red: SKIP (0.000s) [143.873832] [025/131] (871s left) gem_exec_reloc (basic-gtt-cpu) [143.939112] Subtest basic-gtt-cpu: SKIP (0.000s) [144.022423] [026/131] (871s left) kms_addfb_basic (master-rmfb) [144.080473] Starting subtest: master-rmfb [144.082552] Subtest master-rmfb: SUCCESS (0.002s) [144.241674] [027/131] (871s left) gem_render_copy_redux (normal) [144.304690] Starting subtest: normal [144.608019] Subtest normal: SUCCESS (0.303s) [144.754320] [028/131] (871s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [149.825891] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [149.830558] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s) [150.693925] [029/131] (865s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [150.792064] Starting subtest: compare-crc-sanitycheck-xr24 [150.794438] Starting dynamic subtest: pipe-A-eDP-1 [151.408651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.613s) [151.418422] Starting dynamic subtest: pipe-B-eDP-1 [152.629817] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.224s) [152.639198] Starting dynamic subtest: pipe-C-eDP-1 [153.842530] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s) [153.852385] Starting dynamic subtest: pipe-D-eDP-1 [155.063965] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s) [155.066524] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.273s) [155.917848] [030/131] (860s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [155.974131] Starting subtest: single-wait-all-for-submit-available-signaled [155.976207] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [156.078207] [031/131] (859s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [156.184627] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [156.188673] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [156.297178] [032/131] (859s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [156.675258] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [157.526690] [033/131] (858s left) kms_fence_pin_leak [157.692866] [034/131] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [157.790609] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [157.794734] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [157.902500] [035/131] (858s left) gem_exec_schedule (implicit-write-read) [157.976992] Starting subtest: implicit-write-read [157.979346] Starting dynamic subtest: rcs0 [158.076234] Dynamic subtest rcs0: SUCCESS (0.109s) [158.087642] Starting dynamic subtest: vcs0 [158.154504] Dynamic subtest vcs0: SUCCESS (0.078s) [158.163063] Starting dynamic subtest: vcs1 [158.232942] Dynamic subtest vcs1: SUCCESS (0.078s) [158.243203] Starting dynamic subtest: vecs0 [158.308807] Dynamic subtest vecs0: SUCCESS (0.076s) [158.319401] Starting dynamic subtest: ccs0 [158.401519] Dynamic subtest ccs0: SUCCESS (0.092s) [158.404066] Subtest implicit-write-read: SUCCESS (0.435s) [159.989147] [036/131] (856s left) gem_sync (basic-all) [160.049776] Starting subtest: basic-all [163.423250] Subtest basic-all: SUCCESS (3.375s) [163.595095] [037/131] (852s left) kms_psr (psr2-cursor-plane-move) [163.696295] Starting subtest: psr2-cursor-plane-move [163.698652] Starting dynamic subtest: eDP-1 [165.414961] Dynamic subtest eDP-1: SUCCESS (1.715s) [165.417360] Subtest psr2-cursor-plane-move: SUCCESS (1.716s) [166.211669] [038/131] (850s left) kms_getfb (getfb-repeated-different-handles) [166.310293] Starting subtest: getfb-repeated-different-handles [166.312691] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [166.419679] [039/131] (849s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [166.479611] Starting subtest: multi-wait-all-for-submit-unsubmitted [166.584233] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [166.660149] [040/131] (849s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [166.717030] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [166.719353] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [166.815030] [041/131] (849s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [166.914745] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [166.916949] Starting dynamic subtest: pipe-A-default-mode [168.078385] Dynamic subtest pipe-A-default-mode: SKIP (1.158s) [168.085081] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.159s) [168.219754] [042/131] (848s left) gem_spin_batch (spin-each) [168.285020] Starting subtest: spin-each [171.551022] Subtest spin-each: SUCCESS (3.259s) [171.963035] [043/131] (844s left) kms_vblank (wait-forked-hang) [172.062099] Starting subtest: wait-forked-hang [172.064476] Starting dynamic subtest: pipe-A-eDP-1 [198.672650] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.614s) [198.685493] Starting dynamic subtest: pipe-D-eDP-1 [223.640714] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.965s) [223.643029] Subtest wait-forked-hang: SUCCESS (51.583s) [224.504772] [044/131] (791s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [224.601864] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [224.606114] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [224.693083] [045/131] (791s left) api_intel_bb (intel-bb-blit-none) [224.741188] Starting subtest: intel-bb-blit-none [229.291245] Subtest intel-bb-blit-none: SUCCESS (4.551s) [229.408286] [046/131] (787s left) gem_exec_params (no-blt) [229.469057] Starting subtest: no-blt [229.474087] Subtest no-blt: SUCCESS (0.004s) [229.607443] [047/131] (787s left) prime_busy (hang) [229.659986] Starting subtest: hang [229.662263] Starting dynamic subtest: rcs0 [255.411302] Dynamic subtest rcs0: SUCCESS (25.737s) [255.423343] Starting dynamic subtest: bcs0 [262.556410] Dynamic subtest bcs0: SUCCESS (7.157s) [262.564110] Starting dynamic subtest: vcs0 [269.533527] Dynamic subtest vcs0: SUCCESS (6.979s) [269.541526] Starting dynamic subtest: vcs1 [276.583541] Dynamic subtest vcs1: SUCCESS (7.037s) [276.593582] Starting dynamic subtest: vecs0 [283.560787] Dynamic subtest vecs0: SUCCESS (6.978s) [283.571729] Starting dynamic subtest: ccs0 [297.445947] Dynamic subtest ccs0: SUCCESS (13.904s) [297.448959] Subtest hang: SUCCESS (67.797s) [297.571992] [048/131] (719s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [297.663094] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [297.665432] Starting dynamic subtest: pipe-A [297.686063] Dynamic subtest pipe-A: SKIP (0.017s) [297.694853] Starting dynamic subtest: pipe-B [297.718072] Dynamic subtest pipe-B: SKIP (0.030s) [297.728544] Starting dynamic subtest: pipe-C [297.748072] Dynamic subtest pipe-C: SKIP (0.030s) [297.755966] Starting dynamic subtest: pipe-D [297.777619] Dynamic subtest pipe-D: SKIP (0.030s) [297.781954] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.109s) [297.880297] [049/131] (718s left) gem_tiled_wc [297.996937] [050/131] (718s left) kms_psr (fbc-pr-sprite-render) [298.089322] Starting subtest: fbc-pr-sprite-render [298.093450] Subtest fbc-pr-sprite-render: SKIP (0.000s) [298.157827] [051/131] (718s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [298.213057] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [298.217661] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [298.388400] [052/131] (718s left) gen9_exec_parse (bb-chained) [298.443523] Subtest bb-chained: SKIP (0.000s) [298.514803] [053/131] (718s left) syncobj_wait (single-wait-for-submit-unsubmitted) [298.567171] Starting subtest: single-wait-for-submit-unsubmitted [298.672686] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s) [298.748112] [054/131] (718s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [298.860060] Starting subtest: short-busy-flip-before-cursor-toggle [298.864733] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [299.004297] [055/131] (717s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [299.117122] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [299.774140] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s) [299.948473] [056/131] (717s left) gem_exec_whisper (basic-contexts-priority) [300.009569] Starting subtest: basic-contexts-priority [324.908215] Subtest basic-contexts-priority: SUCCESS (24.851s) [325.033430] [057/131] (691s left) gem_softpin (allocator-evict) [325.099642] Starting subtest: allocator-evict [325.102259] Starting dynamic subtest: rcs0 [349.321605] Dynamic subtest rcs0: SUCCESS (24.228s) [349.331905] Starting dynamic subtest: bcs0 [373.115532] Dynamic subtest bcs0: SUCCESS (23.798s) [373.126834] Starting dynamic subtest: vcs0 [396.681904] Dynamic subtest vcs0: SUCCESS (23.569s) [396.691319] Starting dynamic subtest: vcs1 [420.237993] Dynamic subtest vcs1: SUCCESS (23.558s) [420.247871] Starting dynamic subtest: vecs0 [443.817783] Dynamic subtest vecs0: SUCCESS (23.581s) [443.828027] Starting dynamic subtest: ccs0 [467.935504] Dynamic subtest ccs0: SUCCESS (24.120s) [467.938627] Subtest allocator-evict: SUCCESS (142.858s) [468.014676] [058/131] (549s left) kms_psr (fbc-psr-cursor-plane-move) [468.174827] Starting subtest: fbc-psr-cursor-plane-move [468.176749] Starting dynamic subtest: eDP-1 [468.180877] Dynamic subtest eDP-1: SKIP (0.000s) [468.185045] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [468.244891] [059/131] (548s left) gem_create (create-ext-placement-all) [468.408071] Starting subtest: create-ext-placement-all [468.410719] Subtest create-ext-placement-all: SUCCESS (0.000s) [468.521254] [060/131] (548s left) kms_addfb_basic (invalid-get-prop) [468.580415] Starting subtest: invalid-get-prop [468.582621] Subtest invalid-get-prop: SUCCESS (0.000s) [468.713736] [061/131] (548s left) syncobj_timeline (invalid-query-bad-pad) [468.768021] Starting subtest: invalid-query-bad-pad [468.770348] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [468.854257] [062/131] (548s left) kms_lease (cursor-implicit-plane) [468.944784] Starting subtest: cursor-implicit-plane [468.947142] Starting dynamic subtest: pipe-A-eDP-1 [469.403639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s) [469.412276] Starting dynamic subtest: pipe-B-eDP-1 [470.550569] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s) [470.559961] Starting dynamic subtest: pipe-C-eDP-1 [471.658367] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s) [471.668251] Starting dynamic subtest: pipe-D-eDP-1 [472.791681] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [472.794257] Subtest cursor-implicit-plane: SUCCESS (3.847s) [473.659102] [063/131] (543s left) sysfs_timeslice_duration (duration) [473.719775] Starting subtest: duration [473.721991] Starting dynamic subtest: vecs0 [488.817392] Dynamic subtest vecs0: SUCCESS (15.097s) [488.828907] Starting dynamic subtest: ccs0 [501.987531] Dynamic subtest ccs0: SUCCESS (13.170s) [501.999240] Starting dynamic subtest: vcs0 [515.825386] Dynamic subtest vcs0: SUCCESS (13.836s) [515.835645] Starting dynamic subtest: bcs0 [528.983819] Dynamic subtest bcs0: SUCCESS (13.160s) [528.993924] Starting dynamic subtest: rcs0 [542.139055] Dynamic subtest rcs0: SUCCESS (13.155s) [542.150736] Starting dynamic subtest: vcs1 [555.889495] Dynamic subtest vcs1: SUCCESS (13.748s) [555.892747] Subtest duration: SUCCESS (82.177s) [555.970927] [064/131] (461s left) gem_exec_schedule (preempt-user) [556.049637] Starting subtest: preempt-user [556.052040] Starting dynamic subtest: rcs0 [556.078869] Dynamic subtest rcs0: SUCCESS (0.035s) [556.090720] Starting dynamic subtest: bcs0 [556.114209] Dynamic subtest bcs0: SUCCESS (0.035s) [556.123785] Starting dynamic subtest: vcs0 [556.138411] Dynamic subtest vcs0: SUCCESS (0.024s) [556.149478] Starting dynamic subtest: vcs1 [556.165593] Dynamic subtest vcs1: SUCCESS (0.026s) [556.174252] Starting dynamic subtest: vecs0 [556.189238] Dynamic subtest vecs0: SUCCESS (0.024s) [556.197771] Starting dynamic subtest: ccs0 [556.224896] Dynamic subtest ccs0: SUCCESS (0.035s) [556.227248] Subtest preempt-user: SUCCESS (0.182s) [558.009050] [065/131] (459s left) kms_flip (dpms-off-confusion-interruptible) [558.122711] Starting subtest: dpms-off-confusion-interruptible [558.125105] Starting dynamic subtest: A-eDP1 [566.880917] Dynamic subtest A-eDP1: SUCCESS (8.723s) [566.892275] Starting dynamic subtest: B-eDP1 [575.510071] Dynamic subtest B-eDP1: SUCCESS (8.629s) [575.521277] Starting dynamic subtest: C-eDP1 [584.135782] Dynamic subtest C-eDP1: SUCCESS (8.614s) [584.145303] Starting dynamic subtest: D-eDP1 [592.767583] Dynamic subtest D-eDP1: SUCCESS (8.630s) [592.769993] Subtest dpms-off-confusion-interruptible: SUCCESS (34.606s) [593.883459] [066/131] (423s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [593.974064] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [593.976308] Starting dynamic subtest: pipe-A [594.096420] Dynamic subtest pipe-A: SKIP (0.117s) [594.106695] Starting dynamic subtest: pipe-B [595.274882] Dynamic subtest pipe-B: SKIP (1.177s) [595.283266] Starting dynamic subtest: pipe-C [596.494080] Dynamic subtest pipe-C: SUCCESS (1.225s) [596.502643] Starting dynamic subtest: pipe-D [597.720203] Dynamic subtest pipe-D: SUCCESS (1.226s) [597.722871] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.747s) [598.915875] [067/131] (418s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [599.012946] Starting subtest: crc-primary-basic-yf-tiled-ccs [599.015473] Starting dynamic subtest: pipe-A-eDP-1 [599.039601] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [599.050741] Starting dynamic subtest: pipe-B-eDP-1 [599.072732] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [599.081515] Starting dynamic subtest: pipe-C-eDP-1 [599.103505] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [599.112181] Starting dynamic subtest: pipe-D-eDP-1 [599.133870] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [599.138260] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s) [601.190990] [068/131] (416s left) gem_partial_pwrite_pread (reads-snoop) [601.248911] Subtest reads-snoop: SKIP (0.000s) [601.326900] [069/131] (416s left) gen9_exec_parse (allowed-single) [601.396286] Subtest allowed-single: SKIP (0.000s) [601.482602] [070/131] (416s left) kms_busy (extended-modeset-hang-newfb) [601.588191] Starting subtest: extended-modeset-hang-newfb [601.590608] Starting dynamic subtest: pipe-A [635.799957] Dynamic subtest pipe-A: SUCCESS (34.213s) [635.812329] Starting dynamic subtest: pipe-D [658.772668] Dynamic subtest pipe-D: SUCCESS (22.966s) [658.774851] Subtest extended-modeset-hang-newfb: SUCCESS (57.186s) [659.571772] [071/131] (357s left) prime_self_import (basic-llseek-size) [659.603688] Starting subtest: basic-llseek-size [659.626629] Subtest basic-llseek-size: SUCCESS (0.022s) [659.739660] [072/131] (357s left) i915_hangman (engine-engine-error) [659.803179] Starting subtest: engine-engine-error [659.804991] Starting dynamic subtest: rcs0 [660.851388] Dynamic subtest rcs0: SUCCESS (1.048s) [660.862614] Starting dynamic subtest: bcs0 [662.898530] Dynamic subtest bcs0: SUCCESS (2.039s) [662.913104] Starting dynamic subtest: vcs0 [664.881286] Dynamic subtest vcs0: SUCCESS (1.974s) [664.892350] Starting dynamic subtest: vcs1 [666.866545] Dynamic subtest vcs1: SUCCESS (1.977s) [666.878353] Starting dynamic subtest: vecs0 [668.850622] Dynamic subtest vecs0: SUCCESS (1.976s) [668.862317] Starting dynamic subtest: ccs0 [670.897448] Dynamic subtest ccs0: SUCCESS (2.039s) [670.900050] Subtest engine-engine-error: SUCCESS (11.065s) [671.044386] [073/131] (346s left) kms_psr (psr-primary-mmap-gtt) [671.153580] Starting subtest: psr-primary-mmap-gtt [671.155789] Starting dynamic subtest: eDP-1 [672.604993] Dynamic subtest eDP-1: SKIP (1.451s) [672.609896] Subtest psr-primary-mmap-gtt: SKIP (1.453s) [672.787092] [074/131] (344s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [672.894478] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [672.896796] Starting dynamic subtest: A-eDP1 [676.481419] Dynamic subtest A-eDP1: SUCCESS (3.576s) [676.492500] Starting dynamic subtest: B-eDP1 [679.705372] Dynamic subtest B-eDP1: SUCCESS (3.217s) [679.715097] Starting dynamic subtest: C-eDP1 [682.823597] Dynamic subtest C-eDP1: SUCCESS (3.110s) [682.835208] Starting dynamic subtest: D-eDP1 [685.945218] Dynamic subtest D-eDP1: SUCCESS (3.114s) [685.947059] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.024s) [686.744537] [075/131] (330s left) gem_userptr_blits (unsync-unmap-after-close) [686.816564] Subtest unsync-unmap-after-close: SKIP (0.000s) [686.960660] [076/131] (330s left) kms_async_flips (invalid-async-flip) [687.066802] Starting subtest: invalid-async-flip [687.450903] Starting dynamic subtest: pipe-A-eDP-1 [688.273281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s) [688.644299] Starting dynamic subtest: pipe-B-eDP-1 [689.426939] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.789s) [689.785668] Starting dynamic subtest: pipe-C-eDP-1 [690.538251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.755s) [690.892937] Starting dynamic subtest: pipe-D-eDP-1 [691.677220] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.790s) [691.679572] Subtest invalid-async-flip: SUCCESS (4.605s) [692.831228] [077/131] (324s left) perf (non-system-wide-paranoid) [692.966380] Starting subtest: non-system-wide-paranoid [692.993242] Subtest non-system-wide-paranoid: SUCCESS (0.027s) [693.041382] [078/131] (324s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [693.147297] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [693.151229] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [693.238368] [079/131] (324s left) kms_pm_rpm (cursor) [695.065716] Starting subtest: cursor [695.070756] Subtest cursor: SKIP (0.000s) [695.472849] [080/131] (322s left) gem_gpgpu_fill (offset-16x16) [695.538827] Starting subtest: offset-16x16 [695.546141] Subtest offset-16x16: SUCCESS (0.007s) [695.689426] [081/131] (322s left) gem_eio (reset-stress) [695.894662] Starting subtest: reset-stress [739.404587] Subtest reset-stress: SUCCESS (43.470s) [740.918512] [082/131] (277s left) gem_exec_alignment (pi-isolated) [740.977888] Starting subtest: pi-isolated [793.992735] Subtest pi-isolated: SUCCESS (52.990s) [794.949819] [083/131] (223s left) kms_cursor_crc (cursor-sliding-128x128) [795.217871] Starting subtest: cursor-sliding-128x128 [795.223151] Starting dynamic subtest: pipe-A-eDP-1 [798.482291] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.255s) [798.507295] Starting dynamic subtest: pipe-D-eDP-1 [802.414687] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.918s) [802.417125] Subtest cursor-sliding-128x128: SUCCESS (7.197s) [803.277263] [084/131] (214s left) kms_draw_crc (draw-method-mmap-wc) [803.375068] Starting subtest: draw-method-mmap-wc [803.377156] Starting dynamic subtest: xrgb8888-untiled [803.598201] Dynamic subtest xrgb8888-untiled: SUCCESS (0.225s) [803.613412] Starting dynamic subtest: rgb565-untiled [803.820221] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [803.832235] Starting dynamic subtest: xrgb2101010-untiled [804.020246] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.200s) [804.029118] Starting dynamic subtest: xbgr16161616f-untiled [804.219710] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s) [804.228324] Starting dynamic subtest: xrgb8888-xtiled [804.353059] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [804.361496] Starting dynamic subtest: rgb565-xtiled [804.475166] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [804.485236] Starting dynamic subtest: xrgb2101010-xtiled [804.574980] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s) [804.583226] Starting dynamic subtest: xbgr16161616f-xtiled [804.697552] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [804.705706] Starting dynamic subtest: xrgb8888-4tiled [804.852982] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.154s) [804.861555] Starting dynamic subtest: rgb565-4tiled [804.997263] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [805.011392] Starting dynamic subtest: xrgb2101010-4tiled [805.153146] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s) [805.161931] Starting dynamic subtest: xbgr16161616f-4tiled [805.319653] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.165s) [805.321556] Subtest draw-method-mmap-wc: SUCCESS (1.948s) [805.412842] [085/131] (212s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [805.506700] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [805.508665] Starting dynamic subtest: pipe-A-eDP-1 [805.555914] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [805.563688] Starting dynamic subtest: pipe-B-eDP-1 [805.607929] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [805.615680] Starting dynamic subtest: pipe-C-eDP-1 [805.659636] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [805.667011] Starting dynamic subtest: pipe-D-eDP-1 [805.711268] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [805.714533] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s) [807.745131] [086/131] (210s left) kms_getfb (getfb2-into-addfb2) [807.850443] Starting subtest: getfb2-into-addfb2 [807.852469] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [807.962641] [087/131] (210s left) gem_ctx_persistence (legacy-engines-cleanup) [808.020308] Starting subtest: legacy-engines-cleanup [808.022591] Starting dynamic subtest: render [808.135339] Dynamic subtest render: SUCCESS (0.115s) [808.150646] Starting dynamic subtest: bsd1 [808.198760] Dynamic subtest bsd1: SUCCESS (0.061s) [808.211557] Starting dynamic subtest: bsd2 [808.253941] Dynamic subtest bsd2: SUCCESS (0.052s) [808.263149] Starting dynamic subtest: blt [808.300694] Dynamic subtest blt: SUCCESS (0.045s) [808.311504] Starting dynamic subtest: vebox [808.366401] Dynamic subtest vebox: SUCCESS (0.063s) [808.368893] Subtest legacy-engines-cleanup: SUCCESS (0.347s) [808.446104] [088/131] (209s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [808.542384] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [808.546588] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [808.633384] [089/131] (209s left) api_intel_allocator (reloc-allocator) [808.694572] Starting subtest: reloc-allocator [808.696736] Starting dynamic subtest: basic [808.698838] Dynamic subtest basic: SUCCESS (0.003s) [808.714511] Starting dynamic subtest: parallel-one [808.716789] Dynamic subtest parallel-one: SUCCESS (0.007s) [808.727262] Starting dynamic subtest: print [808.728946] Dynamic subtest print: SUCCESS (0.000s) [808.736791] Starting dynamic subtest: reuse [808.738598] Dynamic subtest reuse: SUCCESS (0.000s) [808.748591] Starting dynamic subtest: fork-reopen-allocator [808.750288] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [808.751919] Subtest reloc-allocator: SUCCESS (0.026s) [808.861636] [090/131] (209s left) kms_cursor_crc (cursor-onscreen-max-size) [809.188241] Starting subtest: cursor-onscreen-max-size [809.193877] Subtest cursor-onscreen-max-size: SKIP (0.000s) [809.321412] [091/131] (209s left) api_intel_bb (reset-bb) [809.366731] Starting subtest: reset-bb [809.368648] Subtest reset-bb: SUCCESS (0.004s) [809.483213] [092/131] (208s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [809.592232] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [816.872344] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.282s) [817.018181] [093/131] (201s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [817.114852] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [817.117412] Starting dynamic subtest: pipe-A-eDP-1 [817.141058] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [817.151634] Starting dynamic subtest: pipe-B-eDP-1 [817.173200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [817.182054] Starting dynamic subtest: pipe-C-eDP-1 [817.206591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [817.215691] Starting dynamic subtest: pipe-D-eDP-1 [817.238619] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [817.242698] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [819.349673] [094/131] (199s left) gem_mmap_offset (open-flood) [819.405276] Starting subtest: open-flood [840.894202] Subtest open-flood: SUCCESS (21.491s) [841.023500] [095/131] (177s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [841.134851] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [841.138249] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [841.250427] [096/131] (177s left) kms_prop_blob (blob-prop-lifetime) [841.312023] Starting subtest: blob-prop-lifetime [841.314077] Subtest blob-prop-lifetime: SUCCESS (0.001s) [841.428717] [097/131] (177s left) kms_chamelium_audio (dp-audio-edid) [841.805745] Subtest dp-audio-edid: SKIP (0.000s) [842.666154] [098/131] (175s left) kms_content_protection (mei-interface) [842.822847] Starting subtest: mei-interface [842.834221] Subtest mei-interface: SKIP (0.009s) [842.977291] [099/131] (175s left) kms_chamelium_hpd (dp-hpd) [843.363056] Subtest dp-hpd: SKIP (0.000s) [844.196686] [100/131] (174s left) syncobj_eventfd (invalid-illegal-eventfd) [844.255621] Starting subtest: invalid-illegal-eventfd [844.258108] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [844.357915] [101/131] (174s left) kms_flip (dpms-vs-vblank-race-interruptible) [844.450819] Starting subtest: dpms-vs-vblank-race-interruptible [844.453160] Starting dynamic subtest: A-eDP1 [848.286276] Dynamic subtest A-eDP1: SUCCESS (3.834s) [848.299514] Starting dynamic subtest: B-eDP1 [852.906060] Dynamic subtest B-eDP1: SUCCESS (4.618s) [852.914998] Starting dynamic subtest: C-eDP1 [857.516403] Dynamic subtest C-eDP1: SUCCESS (4.609s) [857.526016] Starting dynamic subtest: D-eDP1 [862.049521] Dynamic subtest D-eDP1: SUCCESS (4.530s) [862.054368] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.602s) [862.926884] [102/131] (155s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [863.027206] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [863.031195] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [863.131574] [103/131] (155s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [863.234885] Starting subtest: fbcpsr-2p-rte [863.238985] Subtest fbcpsr-2p-rte: SKIP (0.000s) [863.347222] [104/131] (155s left) kms_psr (fbc-psr2-sprite-plane-move) [863.449683] Starting subtest: fbc-psr2-sprite-plane-move [863.451669] Starting dynamic subtest: eDP-1 [863.455807] Dynamic subtest eDP-1: SKIP (0.000s) [863.459993] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [863.523836] [105/131] (155s left) kms_big_fb (x-tiled-8bpp-rotate-270) [863.626255] Starting subtest: x-tiled-8bpp-rotate-270 [863.647706] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s) [863.783256] [106/131] (155s left) kms_addfb_basic (addfb25-modifier-no-flag) [863.882898] Starting subtest: addfb25-modifier-no-flag [863.884881] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [864.000384] [107/131] (155s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [864.096809] Starting subtest: bad-aux-stride-yf-tiled-ccs [864.101604] Starting dynamic subtest: pipe-A-eDP-1 [864.120055] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [864.131555] Starting dynamic subtest: pipe-B-eDP-1 [864.149866] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [864.157598] Starting dynamic subtest: pipe-C-eDP-1 [864.175995] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [864.183725] Starting dynamic subtest: pipe-D-eDP-1 [864.201846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [864.205484] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.007s) [866.391026] [108/131] (152s left) drm_mm (drm_mm) [866.434117] Starting subtest: drm_mm [866.476656] Starting dynamic subtest: drm_test_mm_init [866.605953] Dynamic subtest drm_test_mm_init: SUCCESS (0.127s) [866.614307] Starting dynamic subtest: drm_test_mm_debug [866.743380] Dynamic subtest drm_test_mm_debug: SUCCESS (0.137s) [866.751856] Starting dynamic subtest: drm_test_mm_align32 [866.905565] Dynamic subtest drm_test_mm_align32: SUCCESS (0.162s) [866.914107] Starting dynamic subtest: drm_test_mm_align64 [867.033471] Dynamic subtest drm_test_mm_align64: SUCCESS (0.127s) [867.042070] Starting dynamic subtest: drm_test_mm_lowest [867.150086] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.115s) [867.164150] Starting dynamic subtest: drm_test_mm_highest [867.291337] Dynamic subtest drm_test_mm_highest: SUCCESS (0.141s) [867.293225] Subtest drm_mm: SUCCESS (0.855s) [867.458913] [109/131] (151s left) syncobj_wait (wait-for-submit-delayed-submit) [867.514610] Starting subtest: wait-for-submit-delayed-submit [867.617404] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [867.693401] [110/131] (151s left) gem_render_copy (linear) [867.756054] Starting subtest: linear [867.758507] Starting dynamic subtest: smem [867.797053] Dynamic subtest smem: SUCCESS (0.041s) [867.799524] Subtest linear: SUCCESS (0.041s) [868.047820] [111/131] (151s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [868.153728] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [872.436585] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.286s) [873.625137] [112/131] (145s left) perf_pmu (render-node-busy-idle) [873.702174] Starting subtest: render-node-busy-idle [873.704611] Starting dynamic subtest: rcs0 [874.415701] Dynamic subtest rcs0: SUCCESS (0.713s) [874.427331] Starting dynamic subtest: bcs0 [875.090779] Dynamic subtest bcs0: SUCCESS (0.672s) [875.101792] Starting dynamic subtest: vcs0 [876.883373] Dynamic subtest vcs0: SUCCESS (1.789s) [876.894696] Starting dynamic subtest: vcs1 [878.932363] Dynamic subtest vcs1: SUCCESS (2.046s) [878.943853] Starting dynamic subtest: vecs0 [880.916051] Dynamic subtest vecs0: SUCCESS (1.981s) [880.927774] Starting dynamic subtest: ccs0 [881.583614] Dynamic subtest ccs0: SUCCESS (0.667s) [881.586519] Subtest render-node-busy-idle: SUCCESS (7.881s) [881.659773] [113/131] (137s left) kms_plane_alpha_blend (coverage-7efc) [881.759104] Starting subtest: coverage-7efc [882.048383] Starting dynamic subtest: pipe-A-eDP-1 [882.626115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s) [882.657842] Starting dynamic subtest: pipe-D-eDP-1 [883.900615] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [883.902813] Subtest coverage-7efc: SUCCESS (2.140s) [884.761172] [114/131] (134s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [884.864282] Starting subtest: yf-tiled-16bpp-rotate-270 [884.868618] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [884.960217] [115/131] (134s left) gem_workarounds (basic-read-context) [885.027987] Starting subtest: basic-read-context [885.040144] Subtest basic-read-context: SUCCESS (0.010s) [885.181032] [116/131] (134s left) gem_exec_fence (invalid-timeline-fence-array) [885.702820] Starting subtest: invalid-timeline-fence-array [885.708940] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [887.040899] [117/131] (132s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu) [887.142848] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu [893.849724] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.707s) [893.974552] [118/131] (125s left) i915_pm_rc6_residency (rc6-idle) [894.027252] Starting subtest: rc6-idle [894.057194] Starting dynamic subtest: gt0-rcs0 [918.273594] Dynamic subtest gt0-rcs0: SUCCESS (24.212s) [918.282321] Starting dynamic subtest: gt0-bcs0 [942.487159] Dynamic subtest gt0-bcs0: SUCCESS (24.208s) [942.495757] Starting dynamic subtest: gt0-ccs0 [966.766169] Dynamic subtest gt0-ccs0: SUCCESS (24.272s) [966.776974] Starting dynamic subtest: gt1-vcs0 [972.990534] Dynamic subtest gt1-vcs0: SUCCESS (6.168s) [973.002722] Starting dynamic subtest: gt1-vecs0 [979.112232] Dynamic subtest gt1-vecs0: SUCCESS (6.170s) [979.114864] Subtest rc6-idle: SUCCESS (85.070s) [979.190161] [119/131] ( 40s left) syncobj_wait (signal) [979.248551] Starting subtest: signal [979.250469] Subtest signal: SUCCESS (0.000s) [979.355608] [120/131] ( 40s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [979.412847] Starting subtest: multi-wait-available-unsubmitted-submitted [979.415255] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [979.504120] [121/131] ( 40s left) kms_big_fb (x-tiled-32bpp-rotate-90) [979.607678] Starting subtest: x-tiled-32bpp-rotate-90 [979.628397] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s) [979.761590] [122/131] ( 39s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [984.761515] Starting subtest: psr2-overlay-plane-move-continuous-sf [984.763593] Starting dynamic subtest: pipe-A-eDP-1 [991.471363] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.707s) [991.487792] Starting dynamic subtest: pipe-B-eDP-1 [998.204149] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.728s) [998.206553] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.440s) [999.088450] [123/131] ( 20s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [999.194974] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [999.199422] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [999.299958] [124/131] ( 20s left) kms_sequence (get-forked) [999.412320] Starting subtest: get-forked [999.414594] Starting dynamic subtest: pipe-A-eDP-1 [1001.287295] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.872s) [1001.297708] Starting dynamic subtest: pipe-B-eDP-1 [1003.840095] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.552s) [1003.849935] Starting dynamic subtest: pipe-C-eDP-1 [1006.336467] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.494s) [1006.346227] Starting dynamic subtest: pipe-D-eDP-1 [1008.927061] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.589s) [1008.929323] Subtest get-forked: SUCCESS (9.513s) [1009.726729] [125/131] ( 10s left) gem_exec_fence (syncobj-timeline-signal) [1010.259704] Starting subtest: syncobj-timeline-signal [1010.266695] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [1012.031330] [126/131] ( 7s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [1012.133608] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [1012.137744] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [1012.236310] [127/131] ( 7s left) gem_userptr_blits (readonly-unsync) [1012.311140] Subtest readonly-unsync: SKIP (0.000s) [1012.443203] [128/131] ( 7s left) kms_universal_plane (cursor-fb-leak) [1012.544064] Starting subtest: cursor-fb-leak [1012.546233] Starting dynamic subtest: pipe-A-eDP-1 [1012.858416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.313s) [1012.870325] Starting dynamic subtest: pipe-B-eDP-1 [1014.218784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.359s) [1014.228049] Starting dynamic subtest: pipe-C-eDP-1 [1015.553759] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.333s) [1015.563960] Starting dynamic subtest: pipe-D-eDP-1 [1016.876803] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [1016.879287] Subtest cursor-fb-leak: SUCCESS (4.328s) [1018.048889] [129/131] ( 1s left) prime_vgem (coherency-gtt) [1018.133844] Starting subtest: coherency-gtt [1018.138653] Subtest coherency-gtt: SKIP (0.000s) [1018.249122] [130/131] ( 1s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [1018.351793] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [1018.355967] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [1018.463453] [131/131] ( 1s left) gem_pwrite (basic-self) [1018.512727] Subtest basic-self: SKIP (0.000s) [1018.577316] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: kms_feature_discovery 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_frontbuffer_tracking results: parsing output: 5/ for test: vgem_basic results: parsing output: 6/ for test: kms_joiner results: parsing output: 7/ for test: gem_ctx_isolation results: parsing output: 8/ for test: i915_query results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: perf_pmu results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: gem_exec_balancer results: parsing output: 13/ for test: gem_mmap_gtt results: parsing output: 14/ for test: gem_lmem_swapping results: parsing output: 15/ for test: kms_cursor_legacy results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: kms_flip results: parsing output: 18/ for test: gem_ppgtt results: parsing output: 19/ for test: gem_exec_fence results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: kms_chamelium_color results: parsing output: 24/ for test: gem_exec_reloc results: parsing output: 25/ for test: kms_addfb_basic results: parsing output: 26/ for test: gem_render_copy_redux results: parsing output: 27/ for test: kms_psr2_sf results: parsing output: 28/ for test: kms_pipe_crc_basic results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_chamelium_hpd results: parsing output: 32/ for test: kms_fence_pin_leak results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_exec_schedule results: parsing output: 35/ for test: gem_sync results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_getfb results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_flip_scaled_crc results: parsing output: 41/ for test: gem_spin_batch results: parsing output: 42/ for test: kms_vblank results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: api_intel_bb results: parsing output: 45/ for test: gem_exec_params results: parsing output: 46/ for test: prime_busy results: parsing output: 47/ for test: kms_plane_scaling results: parsing output: 48/ for test: gem_tiled_wc results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: gem_render_copy results: parsing output: 51/ for test: gen9_exec_parse results: parsing output: 52/ for test: syncobj_wait results: parsing output: 53/ for test: kms_cursor_legacy results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: gem_exec_whisper results: parsing output: 56/ for test: gem_softpin results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: gem_create results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_lease results: parsing output: 62/ for test: sysfs_timeslice_duration results: parsing output: 63/ for test: gem_exec_schedule results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_plane_scaling results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: gem_partial_pwrite_pread results: parsing output: 68/ for test: gen9_exec_parse results: parsing output: 69/ for test: kms_busy results: parsing output: 70/ for test: prime_self_import results: parsing output: 71/ for test: i915_hangman results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: gem_userptr_blits results: parsing output: 75/ for test: kms_async_flips results: parsing output: 76/ for test: perf results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_pm_rpm results: parsing output: 79/ for test: gem_gpgpu_fill results: parsing output: 80/ for test: gem_eio results: parsing output: 81/ for test: gem_exec_alignment results: parsing output: 82/ for test: kms_cursor_crc results: parsing output: 83/ for test: kms_draw_crc results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: kms_getfb results: parsing output: 86/ for test: gem_ctx_persistence results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: api_intel_allocator results: parsing output: 89/ for test: kms_cursor_crc results: parsing output: 90/ for test: api_intel_bb results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_ccs results: parsing output: 93/ for test: gem_mmap_offset results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_prop_blob results: parsing output: 96/ for test: kms_chamelium_audio results: parsing output: 97/ for test: kms_content_protection results: parsing output: 98/ for test: kms_chamelium_hpd results: parsing output: 99/ for test: syncobj_eventfd results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_psr results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_addfb_basic results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: drm_mm results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: gem_render_copy results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: perf_pmu results: parsing output: 112/ for test: kms_plane_alpha_blend results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: gem_workarounds results: parsing output: 115/ for test: gem_exec_fence results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: i915_pm_rc6_residency results: parsing output: 118/ for test: syncobj_wait results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_psr2_sf results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_sequence results: parsing output: 124/ for test: gem_exec_fence results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_userptr_blits results: parsing output: 127/ for test: kms_universal_plane results: parsing output: 128/ for test: prime_vgem results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_pwrite Done.