[57.153225] Initializing watchdogs [57.153272] /dev/watchdog0 [57.166853] [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.171529] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.173793] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.177215] [001/133] (960s left) syncobj_wait (multi-wait-submitted-signaled) [57.259091] Starting subtest: multi-wait-submitted-signaled [57.261497] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [57.382126] [002/133] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [57.471824] Starting subtest: missing-ccs-buffer-y-tiled-ccs [57.474196] Starting dynamic subtest: pipe-A-eDP-1 [57.496872] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [57.503906] Starting dynamic subtest: pipe-B-eDP-1 [57.525072] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [57.531877] Starting dynamic subtest: pipe-C-eDP-1 [57.552808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [57.559890] Starting dynamic subtest: pipe-D-eDP-1 [57.581842] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [57.585904] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s) [59.730109] [003/133] (958s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [59.824911] Starting subtest: plane-upscale-factor-0-25-with-modifiers [59.827300] Starting dynamic subtest: pipe-A [60.173075] Dynamic subtest pipe-A: SUCCESS (0.349s) [60.183402] Starting dynamic subtest: pipe-B [61.613300] Dynamic subtest pipe-B: SUCCESS (1.437s) [61.622214] Starting dynamic subtest: pipe-C [63.040025] Dynamic subtest pipe-C: SUCCESS (1.424s) [63.050810] Starting dynamic subtest: pipe-D [64.470929] Dynamic subtest pipe-D: SUCCESS (1.428s) [64.473288] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.640s) [65.653567] [004/133] (952s left) gem_ccs (block-copy-compressed) [65.713946] Starting subtest: block-copy-compressed [65.718816] Subtest block-copy-compressed: SKIP (0.000s) [65.826120] [005/133] (952s left) i915_query (query-topology-coherent-slice-mask) [65.883835] Starting subtest: query-topology-coherent-slice-mask [65.888413] Subtest query-topology-coherent-slice-mask: SKIP (0.000s) [65.995910] [006/133] (951s left) syncobj_timeline (invalid-transfer-bad-pad) [66.055588] Starting subtest: invalid-transfer-bad-pad [66.057996] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [66.180351] [007/133] (951s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [66.277980] Starting subtest: primary-x-tiled-reflect-x-180 [73.552196] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.271s) [74.720374] [008/133] (943s left) kms_vrr (max-min) [74.820371] Starting subtest: max-min [74.826946] Subtest max-min: SKIP (0.000s) [74.905138] [009/133] (943s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [75.012385] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [81.613341] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.604s) [81.759975] [010/133] (936s left) kms_psr (pr-cursor-mmap-gtt) [81.852374] Starting subtest: pr-cursor-mmap-gtt [81.856414] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [81.936609] [011/133] (936s left) gem_sync (basic-all) [82.005207] Starting subtest: basic-all [85.849105] Subtest basic-all: SUCCESS (3.850s) [86.043470] [012/133] (932s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [86.112856] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [86.117474] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [86.305011] [013/133] (931s left) kms_atomic_interruptible (atomic-setmode) [86.402600] Starting subtest: atomic-setmode [86.405079] Starting dynamic subtest: pipe-A-eDP-1 [93.308719] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.907s) [93.311356] Subtest atomic-setmode: SUCCESS (6.908s) [94.191786] [014/133] (923s left) gem_pxp (reject-modify-context-protection-off-3) [94.323802] Starting subtest: reject-modify-context-protection-off-3 [94.326549] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [94.437843] [015/133] (923s left) kms_pm_dc (dc5-dpms) [95.538735] Starting subtest: dc5-dpms [97.664466] Subtest dc5-dpms: SUCCESS (2.123s) [97.750624] [016/133] (920s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [97.836258] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [97.838748] Starting dynamic subtest: pipe-A [98.174515] Dynamic subtest pipe-A: SUCCESS (0.340s) [98.181920] Starting dynamic subtest: pipe-B [99.613237] Dynamic subtest pipe-B: SUCCESS (1.438s) [99.623677] Starting dynamic subtest: pipe-C [101.050338] Dynamic subtest pipe-C: SUCCESS (1.437s) [101.059091] Starting dynamic subtest: pipe-D [102.510069] Dynamic subtest pipe-D: SUCCESS (1.459s) [102.512435] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.676s) [103.656721] [017/133] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [103.760741] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [103.764955] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [103.879121] [018/133] (914s left) gem_exec_reloc (basic-wc-read) [103.939726] Subtest basic-wc-read: SKIP (0.000s) [104.009787] [019/133] (914s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [104.108485] Starting subtest: fbc-rgb101010-draw-render [108.683021] Subtest fbc-rgb101010-draw-render: SUCCESS (4.579s) [109.885822] [020/133] (908s left) gem_exec_schedule (semaphore-user) [109.962806] Starting subtest: semaphore-user [110.012935] Subtest semaphore-user: SUCCESS (0.057s) [111.947976] [021/133] (906s left) kms_pm_rpm (universal-planes-dpms) [114.090108] Starting subtest: universal-planes-dpms [114.092882] Starting dynamic subtest: plane-34 [122.298468] Dynamic subtest plane-34: SUCCESS (8.207s) [122.309265] Starting dynamic subtest: plane-64 [130.580622] Dynamic subtest plane-64: SUCCESS (8.280s) [130.591438] Starting dynamic subtest: plane-94 [139.140880] Dynamic subtest plane-94: SUCCESS (8.557s) [139.151798] Starting dynamic subtest: plane-124 [147.492062] Dynamic subtest plane-124: SUCCESS (8.349s) [147.504868] Starting dynamic subtest: plane-134 [156.095082] Dynamic subtest plane-134: SUCCESS (8.600s) [156.105784] Starting dynamic subtest: plane-144 [164.686314] Dynamic subtest plane-144: SUCCESS (8.590s) [164.688827] Subtest universal-planes-dpms: SUCCESS (50.596s) [165.070017] [022/133] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [165.178349] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [165.182412] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [165.297841] [023/133] (853s left) syncobj_wait (reset-multiple-signaled) [165.359078] Starting subtest: reset-multiple-signaled [165.361346] Subtest reset-multiple-signaled: SUCCESS (0.000s) [165.462612] [024/133] (853s left) gem_ctx_param (set-priority-range) [165.529363] Starting subtest: set-priority-range [165.540215] Subtest set-priority-range: SUCCESS (0.014s) [165.669355] [025/133] (852s left) gem_exec_whisper (basic-queues-forked) [165.752825] Starting subtest: basic-queues-forked [190.001891] Subtest basic-queues-forked: SUCCESS (24.246s) [190.199049] [026/133] (828s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [190.299729] Starting subtest: basic-max-pipe-crc-check [190.304771] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [190.344069] [027/133] (828s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [190.434039] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [190.460983] Starting dynamic subtest: pipe-A-plane-0 [190.751067] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [190.766888] Starting dynamic subtest: pipe-A-plane-3 [190.982793] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [190.990998] Starting dynamic subtest: pipe-A-plane-5 [190.995544] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [192.130773] Starting dynamic subtest: pipe-B-plane-0 [192.424898] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [192.433568] Starting dynamic subtest: pipe-B-plane-3 [192.658267] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [192.666656] Starting dynamic subtest: pipe-B-plane-5 [192.670735] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [192.968846] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.535s) [193.832896] [028/133] (824s left) gem_wait (write-busy) [193.905810] Starting subtest: write-busy [193.908147] Starting dynamic subtest: all-engines [194.571739] Dynamic subtest all-engines: SUCCESS (0.666s) [194.586988] Starting dynamic subtest: rcs0 [195.122664] Dynamic subtest rcs0: SUCCESS (0.549s) [195.137674] Starting dynamic subtest: bcs0 [195.669667] Dynamic subtest bcs0: SUCCESS (0.546s) [195.683022] Starting dynamic subtest: vcs0 [196.887446] Dynamic subtest vcs0: SUCCESS (1.215s) [196.902507] Starting dynamic subtest: vcs1 [198.936401] Dynamic subtest vcs1: SUCCESS (2.047s) [198.950839] Starting dynamic subtest: vecs0 [200.919083] Dynamic subtest vecs0: SUCCESS (1.981s) [200.934068] Starting dynamic subtest: ccs0 [201.469485] Dynamic subtest ccs0: SUCCESS (0.550s) [201.471976] Subtest write-busy: SUCCESS (7.563s) [201.673848] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true [201.677178] [029/133] (817s left) kms_addfb_basic (bad-pitch-65536) [201.743303] Starting subtest: bad-pitch-65536 [201.745684] Subtest bad-pitch-65536: SUCCESS (0.000s) [201.910615] [030/133] (816s left) kms_flip (plain-flip-ts-check) [202.008653] Starting subtest: plain-flip-ts-check [202.010617] Starting dynamic subtest: A-eDP1 [210.901065] Dynamic subtest A-eDP1: SUCCESS (8.894s) [210.913907] Starting dynamic subtest: B-eDP1 [219.744537] Dynamic subtest B-eDP1: SUCCESS (8.842s) [219.753080] Starting dynamic subtest: C-eDP1 [228.561782] Dynamic subtest C-eDP1: SUCCESS (8.816s) [228.572763] Starting dynamic subtest: D-eDP1 [237.391115] Dynamic subtest D-eDP1: SUCCESS (8.828s) [237.393542] Subtest plain-flip-ts-check: SUCCESS (35.388s) [238.582568] [031/133] (780s left) gem_userptr_blits (unsync-unmap-cycles) [238.658677] Subtest unsync-unmap-cycles: SKIP (0.000s) [238.809815] [032/133] (780s left) gem_mmap_offset (basic-uaf) [238.868357] Starting subtest: basic-uaf [238.870710] Subtest basic-uaf: SUCCESS (0.001s) [238.984251] [033/133] (779s left) core_getversion (all-cards) [239.028058] Starting subtest: all-cards [239.035757] Subtest all-cards: SUCCESS (0.010s) [239.075412] [034/133] (779s left) gem_exec_whisper (basic-contexts) [239.142824] Starting subtest: basic-contexts [245.060662] Subtest basic-contexts: SUCCESS (5.919s) [245.255937] [035/133] (773s left) kms_feature_discovery (display) [245.363065] Starting subtest: display [245.365308] Subtest display: SUCCESS (0.000s) [245.457917] [036/133] (773s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [245.560391] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [253.067669] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.509s) [253.241726] [037/133] (765s left) gem_mmap_wc (bad-offset) [253.305691] Subtest bad-offset: SKIP (0.000s) [253.376394] [038/133] (765s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [253.506993] Starting subtest: cursorB-vs-flipB-varying-size [253.511553] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [253.674377] [039/133] (765s left) perf_pmu (module-unload) [253.760076] Starting subtest: module-unload [262.181715] Subtest module-unload: FAIL (8.319s) [262.212854] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [262.213600] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [262.216640] [040/133] (756s left) i915_hangman (detector) [263.777201] Starting subtest: detector [263.779542] Starting dynamic subtest: rcs0 [274.871112] Dynamic subtest rcs0: SUCCESS (11.092s) [274.879527] Starting dynamic subtest: bcs0 [286.842042] Dynamic subtest bcs0: SUCCESS (11.968s) [286.854257] Starting dynamic subtest: vcs0 [298.807037] Dynamic subtest vcs0: SUCCESS (11.963s) [298.818210] Starting dynamic subtest: vcs1 [309.814470] Dynamic subtest vcs1: SUCCESS (11.004s) [309.825321] Starting dynamic subtest: vecs0 [320.822284] Dynamic subtest vecs0: SUCCESS (11.005s) [320.834835] Starting dynamic subtest: ccs0 [332.854612] Dynamic subtest ccs0: SUCCESS (12.030s) [332.857376] Subtest detector: SUCCESS (69.076s) [332.905206] [FACT i915_hangman (detector)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [332.906388] [FACT i915_hangman (detector)] new: kernel.kmod_is_loaded.i915: true [332.910088] [041/133] (686s left) syncobj_basic (create-signaled) [332.986660] Starting subtest: create-signaled [332.989048] Subtest create-signaled: SUCCESS (0.000s) [333.115810] [042/133] (686s left) gem_exec_fence (submit3) [333.299640] Starting subtest: submit3 [333.304761] Subtest submit3: SKIP (0.000s) [335.025341] [043/133] (684s left) kms_chamelium_edid (hdmi-edid-read) [335.416944] Subtest hdmi-edid-read: SKIP (0.000s) [336.213753] [044/133] (683s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [336.310257] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [336.312536] Starting dynamic subtest: pipe-A-eDP-1 [336.334113] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [336.343314] Starting dynamic subtest: pipe-B-eDP-1 [336.364685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [336.373210] Starting dynamic subtest: pipe-C-eDP-1 [336.394721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [336.403560] Starting dynamic subtest: pipe-D-eDP-1 [336.427427] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [336.431657] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s) [338.626149] [045/133] (680s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [338.726796] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [345.222619] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.497s) [345.362224] [046/133] (674s left) syncobj_timeline (etime-single-wait-all-submitted) [345.425100] Starting subtest: etime-single-wait-all-submitted [345.531782] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s) [345.617639] [047/133] (673s left) gem_exec_capture (pi) [345.678236] Starting subtest: pi [345.680571] Starting dynamic subtest: rcs0 [350.134997] Dynamic subtest rcs0: SUCCESS (4.459s) [350.145055] Starting dynamic subtest: bcs0 [354.386038] Dynamic subtest bcs0: SUCCESS (4.248s) [354.397810] Starting dynamic subtest: vcs0 [358.614965] Dynamic subtest vcs0: SUCCESS (4.227s) [358.625629] Starting dynamic subtest: vcs1 [362.782813] Dynamic subtest vcs1: SUCCESS (4.165s) [362.793837] Starting dynamic subtest: vecs0 [366.928711] Dynamic subtest vecs0: SUCCESS (4.143s) [366.945142] Starting dynamic subtest: ccs0 [371.112625] Dynamic subtest ccs0: SUCCESS (4.182s) [371.115066] Subtest pi: SUCCESS (25.437s) [371.218268] [048/133] (648s left) kms_flip (nonblocking-read) [371.378223] Starting subtest: nonblocking-read [371.380106] Subtest nonblocking-read: SUCCESS (0.000s) [371.495596] [049/133] (648s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [371.600308] Starting subtest: yf-tiled-16bpp-rotate-90 [371.604627] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [371.721361] [050/133] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [371.824051] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [371.828235] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [371.942568] [051/133] (647s left) gem_softpin (full) [372.004951] Starting subtest: full [372.013537] Subtest full: SUCCESS (0.009s) [372.157096] [052/133] (647s left) kms_chamelium_hpd (vga-hpd-after-suspend) [372.544771] Subtest vga-hpd-after-suspend: SKIP (0.000s) [373.354645] [053/133] (646s left) perf (rc6-disable) [373.512434] Starting subtest: rc6-disable [373.691518] Subtest rc6-disable: SUCCESS (0.179s) [373.734014] [054/133] (646s left) gem_partial_pwrite_pread (reads-snoop) [373.796220] Subtest reads-snoop: SKIP (0.000s) [373.877883] [055/133] (645s left) kms_cursor_crc (cursor-rapid-movement-512x512) [374.156965] Starting subtest: cursor-rapid-movement-512x512 [374.161594] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [374.327096] [056/133] (645s left) gem_mmap_gtt (cpuset-big-copy) [374.376155] Subtest cpuset-big-copy: SKIP (0.000s) [374.437390] [057/133] (645s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [374.550178] Starting subtest: modeset-atomic-cursor-hotspot [374.553934] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [374.707557] [058/133] (645s left) kms_psr (psr-sprite-mmap-cpu) [374.802995] Starting subtest: psr-sprite-mmap-cpu [374.804957] Starting dynamic subtest: eDP-1 [376.592401] Dynamic subtest eDP-1: SUCCESS (1.788s) [376.594574] Subtest psr-sprite-mmap-cpu: SUCCESS (1.789s) [377.442659] [059/133] (642s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [377.534085] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [377.538137] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [377.660445] [060/133] (642s left) gem_exec_reloc (basic-wc-cpu-active) [377.720536] Subtest basic-wc-cpu-active: SKIP (0.000s) [377.802974] [061/133] (642s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [377.889754] Starting subtest: basic-modeset-with-all-modifiers-formats [378.271058] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [379.005670] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.736s) [379.014727] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [379.027699] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s) [379.036731] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [379.049577] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s) [379.058646] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [379.205487] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s) [379.216701] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [379.227854] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s) [379.237072] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [379.250265] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s) [379.265456] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [379.272250] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s) [379.282862] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [379.294763] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s) [379.309229] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [379.316805] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s) [379.329055] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [379.339126] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s) [379.350601] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [379.361279] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s) [379.372161] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [379.383063] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s) [379.391864] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [379.528225] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s) [379.539616] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [379.550179] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s) [379.559186] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [379.572373] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s) [379.581378] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [379.594517] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s) [379.603714] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [379.616452] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s) [379.625461] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [379.639044] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s) [379.648305] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [379.661242] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s) [379.670279] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [379.683397] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s) [379.692609] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [379.705323] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s) [379.714901] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [379.861618] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s) [379.870960] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [379.883858] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s) [379.893355] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [379.906113] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s) [379.916955] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [379.928217] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s) [379.937458] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [379.950647] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s) [379.960933] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [379.972220] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s) [379.983379] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [379.994739] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s) [380.003733] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [380.016608] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s) [380.025681] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [380.038962] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s) [380.424327] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.535s) [381.219122] [062/133] (638s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [381.320057] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [381.324591] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [382.427094] [063/133] (637s left) kms_flip (flip-vs-dpms-on-nop) [382.521376] Starting subtest: flip-vs-dpms-on-nop [382.523746] Starting dynamic subtest: A-eDP1 [384.393601] Dynamic subtest A-eDP1: SUCCESS (1.874s) [384.405454] Starting dynamic subtest: B-eDP1 [386.227947] Dynamic subtest B-eDP1: SUCCESS (1.833s) [386.239822] Starting dynamic subtest: C-eDP1 [388.052753] Dynamic subtest C-eDP1: SUCCESS (1.822s) [388.063996] Starting dynamic subtest: D-eDP1 [389.887465] Dynamic subtest D-eDP1: SUCCESS (1.833s) [389.893038] Subtest flip-vs-dpms-on-nop: SUCCESS (7.373s) [391.076111] [064/133] (629s left) vgem_basic (unload) [391.116138] Starting subtest: unload [420.260914] Subtest unload: SUCCESS (29.145s) [420.386444] [065/133] (599s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [420.512652] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [420.515053] Starting dynamic subtest: pipe-A-default-mode [421.622691] Dynamic subtest pipe-A-default-mode: SKIP (1.107s) [421.627237] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.109s) [421.805141] [066/133] (598s left) syncobj_wait (multi-wait-signaled) [421.881296] Starting subtest: multi-wait-signaled [421.883139] Subtest multi-wait-signaled: SUCCESS (0.000s) [422.001280] [067/133] (598s left) kms_properties (get_properties-sanity-atomic) [422.105926] Starting subtest: get_properties-sanity-atomic [422.110321] Subtest get_properties-sanity-atomic: SUCCESS (0.005s) [422.206684] [068/133] (598s left) sysfs_heartbeat_interval (nopreempt) [422.277300] Starting subtest: nopreempt [422.279561] Starting dynamic subtest: vecs0 [431.921857] Dynamic subtest vecs0: SUCCESS (9.640s) [431.933826] Starting dynamic subtest: ccs0 [436.061023] Dynamic subtest ccs0: SUCCESS (4.138s) [436.071637] Starting dynamic subtest: vcs0 [445.918013] Dynamic subtest vcs0: SUCCESS (9.853s) [445.933935] Starting dynamic subtest: bcs0 [449.950317] Dynamic subtest bcs0: SUCCESS (4.032s) [449.961184] Starting dynamic subtest: rcs0 [454.089597] Dynamic subtest rcs0: SUCCESS (4.137s) [454.101559] Starting dynamic subtest: vcs1 [463.906795] Dynamic subtest vcs1: SUCCESS (9.813s) [463.909491] Subtest nopreempt: SUCCESS (41.626s) [464.007565] [069/133] (556s left) kms_async_flips (test-time-stamp-atomic) [464.114131] Starting subtest: test-time-stamp-atomic [464.491213] Starting dynamic subtest: pipe-A-eDP-1 [465.288188] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s) [465.681493] Starting dynamic subtest: pipe-B-eDP-1 [466.423734] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s) [466.786962] Starting dynamic subtest: pipe-C-eDP-1 [467.546840] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [467.910081] Starting dynamic subtest: pipe-D-eDP-1 [468.679725] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s) [468.682195] Subtest test-time-stamp-atomic: SUCCESS (4.566s) [469.856572] [070/133] (550s left) kms_busy (extended-pageflip-hang-newfb) [469.970871] Starting subtest: extended-pageflip-hang-newfb [469.973717] Starting dynamic subtest: pipe-A [496.683724] Dynamic subtest pipe-A: SUCCESS (26.713s) [496.694536] Starting dynamic subtest: pipe-D [521.723135] Dynamic subtest pipe-D: SUCCESS (25.034s) [521.725434] Subtest extended-pageflip-hang-newfb: SUCCESS (51.753s) [522.526425] [071/133] (497s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [522.633353] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [522.638042] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [522.766352] [072/133] (497s left) i915_pm_sseu (full-enable) [522.840311] Subtest full-enable: SKIP (0.000s) [522.979905] [073/133] (497s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [523.074990] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [523.079198] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [523.213227] [074/133] (497s left) kms_vblank (query-busy) [523.319215] Starting subtest: query-busy [523.321376] Starting dynamic subtest: pipe-A-eDP-1 [525.206590] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s) [525.220710] Starting dynamic subtest: pipe-D-eDP-1 [527.793194] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s) [527.795072] Subtest query-busy: SUCCESS (4.474s) [528.605747] [075/133] (492s left) kms_psr (fbc-psr2-primary-blt) [528.710247] Starting subtest: fbc-psr2-primary-blt [528.712577] Starting dynamic subtest: eDP-1 [528.716738] Dynamic subtest eDP-1: SKIP (0.000s) [528.720906] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [528.809528] [076/133] (491s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [528.907488] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [528.911712] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [529.024800] [077/133] (491s left) gem_ctx_param (vm) [529.080409] Starting subtest: vm [529.131489] Subtest vm: SUCCESS (0.051s) [529.275882] [078/133] (491s left) kms_big_fb (linear-64bpp-rotate-0) [529.375611] Starting subtest: linear-64bpp-rotate-0 [530.888818] Subtest linear-64bpp-rotate-0: SUCCESS (1.512s) [531.092807] [079/133] (489s left) gem_exec_parallel (engines) [531.156477] Starting subtest: engines [531.158964] Starting dynamic subtest: basic [532.887889] Dynamic subtest basic: SUCCESS (1.729s) [532.899932] Starting dynamic subtest: contexts [537.330352] Dynamic subtest contexts: SUCCESS (4.439s) [537.345360] Starting dynamic subtest: fds [541.169845] Dynamic subtest fds: SUCCESS (3.837s) [541.180489] Starting dynamic subtest: userptr [542.963099] Dynamic subtest userptr: SUCCESS (1.790s) [542.965698] Subtest engines: SUCCESS (11.805s) [543.168355] [080/133] (477s left) perf (invalid-create-userspace-config) [543.269617] Starting subtest: invalid-create-userspace-config [543.272128] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [543.316861] [081/133] (477s left) gem_exec_balancer (individual) [543.384348] Starting subtest: individual [544.944458] Subtest individual: SUCCESS (1.558s) [545.293686] [082/133] (475s left) api_intel_allocator (execbuf-with-allocator) [545.350072] Starting subtest: execbuf-with-allocator [545.357353] Subtest execbuf-with-allocator: SUCCESS (0.009s) [545.524034] [083/133] (475s left) kms_cursor_edge_walk (64x64-top-edge) [545.621109] Starting subtest: 64x64-top-edge [545.623778] Starting dynamic subtest: pipe-A-eDP-1 [549.050143] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s) [549.059819] Starting dynamic subtest: pipe-D-eDP-1 [552.173469] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [552.175841] Subtest 64x64-top-edge: SUCCESS (6.554s) [553.015017] [084/133] (468s left) kms_psr (fbc-psr-cursor-plane-onoff) [553.107968] Starting subtest: fbc-psr-cursor-plane-onoff [553.110285] Starting dynamic subtest: eDP-1 [553.114590] Dynamic subtest eDP-1: SKIP (0.000s) [553.118953] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [553.191990] [085/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [553.294897] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [553.299424] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [553.405712] [086/133] (467s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [553.471983] Starting subtest: y-tiled-ccs-to-y-tiled [553.475843] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [553.669492] [087/133] (467s left) gem_mmap_wc (close) [553.730708] Subtest close: SKIP (0.000s) [553.801643] [088/133] (467s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [553.899048] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [553.926347] Starting dynamic subtest: pipe-A-plane-0 [553.930808] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [553.943373] Starting dynamic subtest: pipe-A-plane-3 [553.948920] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [553.968906] Starting dynamic subtest: pipe-A-plane-5 [553.973660] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [555.090280] Starting dynamic subtest: pipe-B-plane-0 [555.094425] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [555.104076] Starting dynamic subtest: pipe-B-plane-3 [555.108555] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [555.117956] Starting dynamic subtest: pipe-B-plane-5 [555.122069] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [555.405609] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (1.504s) [556.280899] [089/133] (464s left) kms_big_fb (x-tiled-16bpp-rotate-270) [556.387983] Starting subtest: x-tiled-16bpp-rotate-270 [556.410425] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [556.571443] [090/133] (464s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [556.682600] Starting subtest: yf-tiled-addfb-size-offset-overflow [556.686729] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [556.814671] [091/133] (464s left) sw_sync (sync_expired_merge) [556.849342] Starting subtest: sync_expired_merge [557.923940] Subtest sync_expired_merge: SUCCESS (1.074s) [557.997903] [092/133] (463s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [558.105574] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area [558.109802] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [558.196681] [093/133] (463s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [558.284998] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [565.260862] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.979s) [565.420139] [094/133] (456s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [565.527601] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [565.529766] Starting dynamic subtest: pipe-A-eDP-1 [571.480935] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.958s) [571.491120] Starting dynamic subtest: pipe-B-eDP-1 [578.151096] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.669s) [578.153371] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.630s) [579.032316] [095/133] (442s left) gem_create (create-ext-cpu-access-big) [579.192053] Starting subtest: create-ext-cpu-access-big [579.197053] Subtest create-ext-cpu-access-big: SKIP (0.001s) [579.291885] [096/133] (442s left) gem_ctx_persistence (saturated-hostile) [579.345522] Starting subtest: saturated-hostile [579.347954] Starting dynamic subtest: rcs0 [580.197667] Dynamic subtest rcs0: SUCCESS (0.852s) [580.210515] Starting dynamic subtest: bcs0 [581.011372] Dynamic subtest bcs0: SUCCESS (0.812s) [581.023733] Starting dynamic subtest: vcs0 [581.807479] Dynamic subtest vcs0: SUCCESS (0.794s) [581.818090] Starting dynamic subtest: vcs1 [582.618728] Dynamic subtest vcs1: SUCCESS (0.809s) [582.630474] Starting dynamic subtest: vecs0 [583.422143] Dynamic subtest vecs0: SUCCESS (0.801s) [583.434314] Starting dynamic subtest: ccs0 [584.254124] Dynamic subtest ccs0: SUCCESS (0.830s) [584.256540] Subtest saturated-hostile: SUCCESS (4.910s) [584.403159] [097/133] (437s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [584.463097] Starting subtest: wait-all-for-submit-delayed-submit [584.565432] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [584.658655] [098/133] (436s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [584.756449] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [584.760986] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [584.874467] [099/133] (436s left) kms_content_protection (atomic-hdcp14) [585.006957] Starting subtest: atomic-hdcp14 [585.011491] Subtest atomic-hdcp14: SKIP (0.000s) [585.154476] [100/133] (436s left) gem_tiled_blits (normal) [585.213672] Subtest normal: SKIP (0.000s) [585.303423] [101/133] (436s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [585.412386] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [585.415941] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [585.549059] [102/133] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [585.658031] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [585.661625] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [585.787867] [103/133] (436s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [585.888775] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [585.890499] Starting dynamic subtest: pipe-A-eDP-1 [587.161139] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.273s) [587.171311] Starting dynamic subtest: pipe-B-eDP-1 [589.472092] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.310s) [589.482699] Starting dynamic subtest: pipe-C-eDP-1 [591.808807] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.332s) [591.825430] Starting dynamic subtest: pipe-D-eDP-1 [594.131516] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.323s) [594.133926] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.245s) [595.348896] [104/133] (426s left) gem_exec_schedule (implicit-write-read) [595.438102] Starting subtest: implicit-write-read [595.440127] Starting dynamic subtest: rcs0 [595.531820] Dynamic subtest rcs0: SUCCESS (0.104s) [595.544593] Starting dynamic subtest: vcs0 [595.614943] Dynamic subtest vcs0: SUCCESS (0.082s) [595.628152] Starting dynamic subtest: vcs1 [595.693176] Dynamic subtest vcs1: SUCCESS (0.077s) [595.707254] Starting dynamic subtest: vecs0 [595.786038] Dynamic subtest vecs0: SUCCESS (0.092s) [595.798715] Starting dynamic subtest: ccs0 [595.879069] Dynamic subtest ccs0: SUCCESS (0.092s) [595.882030] Subtest implicit-write-read: SUCCESS (0.452s) [597.018071] [105/133] (424s left) core_auth (getclient-simple) [597.061414] Starting subtest: getclient-simple [597.075235] Subtest getclient-simple: SUCCESS (0.014s) [597.187950] [106/133] (424s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [597.290578] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [597.948129] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s) [598.177394] [107/133] (423s left) i915_drm_fdinfo (basics) [598.221079] Starting subtest: basics [598.222934] Subtest basics: SUCCESS (0.000s) [598.297611] [108/133] (423s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [598.404449] Starting subtest: fbcpsr-rgb101010-draw-blt [605.226401] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.824s) [605.364442] [109/133] (416s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [605.493990] Starting subtest: short-flip-before-cursor-toggle [606.409038] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s) [607.308023] [110/133] (414s left) kms_color (invalid-degamma-lut-sizes) [607.401981] Starting subtest: invalid-degamma-lut-sizes [607.404290] Starting dynamic subtest: pipe-A [607.688956] Dynamic subtest pipe-A: SUCCESS (0.286s) [607.699529] Starting dynamic subtest: pipe-B [607.701932] Dynamic subtest pipe-B: SUCCESS (0.000s) [607.711765] Starting dynamic subtest: pipe-C [607.714199] Dynamic subtest pipe-C: SUCCESS (0.000s) [607.723508] Starting dynamic subtest: pipe-D [607.725838] Dynamic subtest pipe-D: SUCCESS (0.000s) [607.728159] Subtest invalid-degamma-lut-sizes: SUCCESS (0.290s) [608.533623] [111/133] (413s left) kms_invalid_mode (bad-vsync-start) [608.642840] Starting subtest: bad-vsync-start [608.645256] Starting dynamic subtest: pipe-A-eDP-1 [608.929513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [608.939747] Starting dynamic subtest: pipe-B-eDP-1 [608.941996] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [608.951521] Starting dynamic subtest: pipe-C-eDP-1 [608.953533] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [608.962670] Starting dynamic subtest: pipe-D-eDP-1 [608.964774] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [608.966802] Subtest bad-vsync-start: SUCCESS (0.294s) [609.757581] [112/133] (412s left) kms_vblank (wait-forked) [609.861109] Starting subtest: wait-forked [609.863356] Starting dynamic subtest: pipe-A-eDP-1 [611.690898] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.829s) [611.711953] Starting dynamic subtest: pipe-D-eDP-1 [614.235664] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s) [614.238080] Subtest wait-forked: SUCCESS (4.376s) [615.110881] [113/133] (407s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [615.212526] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [615.217140] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [615.346056] [114/133] (406s left) kms_fence_pin_leak [615.513821] [115/133] (406s left) gem_userptr_blits (usage-restrictions) [615.590291] Starting subtest: usage-restrictions [615.592535] Subtest usage-restrictions: SUCCESS (0.000s) [615.724743] [116/133] (406s left) kms_lease (lease-unleased-crtc) [615.827241] Starting subtest: lease-unleased-crtc [615.829536] Starting dynamic subtest: pipe-A-eDP-1 [616.117539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [616.129100] Starting dynamic subtest: pipe-B-eDP-1 [616.850667] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.729s) [616.862490] Starting dynamic subtest: pipe-C-eDP-1 [616.864675] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [616.874307] Starting dynamic subtest: pipe-D-eDP-1 [616.876557] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [616.878712] Subtest lease-unleased-crtc: SUCCESS (1.039s) [617.249648] [117/133] (405s left) gem_caching (writes) [617.313505] Subtest writes: SKIP (0.000s) [617.387180] [118/133] (405s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [617.490227] Starting subtest: pr-overlay-plane-update-continuous-sf [617.494249] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [617.572655] [119/133] (404s left) kms_flip (2x-plain-flip-fb-recreate) [617.702381] Starting subtest: 2x-plain-flip-fb-recreate [617.726510] Subtest 2x-plain-flip-fb-recreate: SKIP (0.023s) [617.840222] [120/133] (404s left) gem_tiled_partial_pwrite_pread (reads) [617.905970] Subtest reads: SKIP (0.000s) [617.987226] [121/133] (404s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [618.078722] Starting subtest: psr-indfb-scaledprimary [623.806303] Subtest psr-indfb-scaledprimary: SUCCESS (5.730s) [623.954564] [122/133] (398s left) syncobj_timeline (multi-wait-available-signaled) [624.010646] Starting subtest: multi-wait-available-signaled [624.013091] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [624.136131] [123/133] (398s left) gem_exec_reloc (basic-cpu-gtt) [624.189819] Subtest basic-cpu-gtt: SKIP (0.000s) [624.273433] [124/133] (398s left) gem_shrink (reclaim) [624.339915] Starting subtest: reclaim [626.788916] Subtest reclaim: SUCCESS (2.451s) [626.915949] [125/133] (395s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [627.032251] Starting subtest: fbc-rgb101010-draw-blt [631.653075] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.626s) [632.842082] [126/133] (389s left) gem_ctx_sseu (engines) [632.904130] Subtest engines: SKIP (0.000s) [633.006912] [127/133] (389s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [633.065230] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [633.172532] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s) [633.262125] [128/133] (389s left) gen9_exec_parse (bb-start-far) [633.322480] Subtest bb-start-far: SKIP (0.000s) [633.411517] [129/133] (389s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [633.506818] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [633.508626] Starting dynamic subtest: pipe-A-eDP-1 [635.630570] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.124s) [635.640230] Starting dynamic subtest: pipe-B-eDP-1 [637.918074] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.287s) [637.927260] Starting dynamic subtest: pipe-C-eDP-1 [640.116824] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.198s) [640.126481] Starting dynamic subtest: pipe-D-eDP-1 [642.158103] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.039s) [642.160394] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.652s) [643.385388] [130/133] (379s left) prime_vgem (sync) [643.472278] Starting subtest: sync [643.474626] Starting dynamic subtest: rcs0 [643.556264] Dynamic subtest rcs0: SUCCESS (0.085s) [643.566500] Starting dynamic subtest: bcs0 [643.651244] Dynamic subtest bcs0: SUCCESS (0.094s) [643.661081] Starting dynamic subtest: vcs0 [643.701442] Dynamic subtest vcs0: SUCCESS (0.048s) [643.711266] Starting dynamic subtest: vcs1 [643.748140] Dynamic subtest vcs1: SUCCESS (0.046s) [643.757787] Starting dynamic subtest: vecs0 [643.794330] Dynamic subtest vecs0: SUCCESS (0.045s) [643.804129] Starting dynamic subtest: ccs0 [643.840775] Dynamic subtest ccs0: SUCCESS (0.046s) [643.843072] Subtest sync: SUCCESS (0.371s) [643.992500] [131/133] (379s left) i915_pm_rpm (gem-execbuf-stress-pc8) [646.130272] Starting subtest: gem-execbuf-stress-pc8 [646.168482] Subtest gem-execbuf-stress-pc8: SKIP (0.041s) [646.522652] [132/133] (376s left) kms_cursor_crc (cursor-onscreen-128x128) [646.741383] Starting subtest: cursor-onscreen-128x128 [646.746272] Starting dynamic subtest: pipe-A-eDP-1 [648.853525] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s) [648.884794] Starting dynamic subtest: pipe-D-eDP-1 [651.666857] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.789s) [651.669066] Subtest cursor-onscreen-128x128: SUCCESS (4.923s) [652.471124] [133/133] (370s left) kms_psr (psr2-sprite-blt) [652.580893] Starting subtest: psr2-sprite-blt [652.583136] Starting dynamic subtest: eDP-1 [654.257676] Dynamic subtest eDP-1: SUCCESS (1.676s) [654.259904] Subtest psr2-sprite-blt: SUCCESS (1.677s) [655.127521] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: gem_ccs results: parsing output: 4/ for test: i915_query results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: kms_rotation_crc results: parsing output: 7/ for test: kms_vrr results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: gem_sync results: parsing output: 11/ for test: gem_render_copy results: parsing output: 12/ for test: kms_atomic_interruptible results: parsing output: 13/ for test: gem_pxp results: parsing output: 14/ for test: kms_pm_dc results: parsing output: 15/ for test: kms_plane_scaling results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_exec_reloc results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: kms_pm_rpm results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: gem_ctx_param results: parsing output: 24/ for test: gem_exec_whisper results: parsing output: 25/ for test: kms_multipipe_modeset results: parsing output: 26/ for test: kms_plane results: parsing output: 27/ for test: gem_wait results: parsing output: 28/ for test: kms_addfb_basic results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: gem_userptr_blits results: parsing output: 31/ for test: gem_mmap_offset results: parsing output: 32/ for test: core_getversion results: parsing output: 33/ for test: gem_exec_whisper results: parsing output: 34/ for test: kms_feature_discovery results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_mmap_wc results: parsing output: 37/ for test: kms_cursor_legacy results: parsing output: 38/ for test: perf_pmu results: parsing output: 39/ for test: i915_hangman results: parsing output: 40/ for test: syncobj_basic results: parsing output: 41/ for test: gem_exec_fence results: parsing output: 42/ for test: kms_chamelium_edid results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: syncobj_timeline results: parsing output: 46/ for test: gem_exec_capture results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_softpin results: parsing output: 51/ for test: kms_chamelium_hpd results: parsing output: 52/ for test: perf results: parsing output: 53/ for test: gem_partial_pwrite_pread results: parsing output: 54/ for test: kms_cursor_crc results: parsing output: 55/ for test: gem_mmap_gtt results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_exec_reloc results: parsing output: 60/ for test: kms_async_flips results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_flip results: parsing output: 63/ for test: vgem_basic results: parsing output: 64/ for test: kms_flip_scaled_crc results: parsing output: 65/ for test: syncobj_wait results: parsing output: 66/ for test: kms_properties results: parsing output: 67/ for test: sysfs_heartbeat_interval results: parsing output: 68/ for test: kms_async_flips results: parsing output: 69/ for test: kms_busy results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: i915_pm_sseu results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_vblank results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_ctx_param results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: gem_exec_parallel results: parsing output: 79/ for test: perf results: parsing output: 80/ for test: gem_exec_balancer results: parsing output: 81/ for test: api_intel_allocator results: parsing output: 82/ for test: kms_cursor_edge_walk results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_render_copy results: parsing output: 86/ for test: gem_mmap_wc results: parsing output: 87/ for test: kms_plane results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: sw_sync results: parsing output: 91/ for test: kms_psr2_sf results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_psr2_sf results: parsing output: 94/ for test: gem_create results: parsing output: 95/ for test: gem_ctx_persistence results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_content_protection results: parsing output: 99/ for test: gem_tiled_blits results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: gem_exec_schedule results: parsing output: 104/ for test: core_auth results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: i915_drm_fdinfo results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_cursor_legacy results: parsing output: 109/ for test: kms_color results: parsing output: 110/ for test: kms_invalid_mode results: parsing output: 111/ for test: kms_vblank results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_fence_pin_leak results: parsing output: 114/ for test: gem_userptr_blits results: parsing output: 115/ for test: kms_lease results: parsing output: 116/ for test: gem_caching results: parsing output: 117/ for test: kms_psr2_sf results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: gem_exec_reloc results: parsing output: 123/ for test: gem_shrink results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_ctx_sseu results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: gen9_exec_parse results: parsing output: 128/ for test: kms_ccs results: parsing output: 129/ for test: prime_vgem results: parsing output: 130/ for test: i915_pm_rpm results: parsing output: 131/ for test: kms_cursor_crc results: parsing output: 132/ for test: kms_psr Done.