[63.769167] Initializing watchdogs [63.769216] /dev/watchdog0 [63.782829] [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] [63.787352] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.789436] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.792302] [001/133] (960s left) gem_exec_reloc (basic-write-read) [63.873827] Subtest basic-write-read: SKIP (0.000s) [63.941268] [002/133] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [63.993293] Starting subtest: invalid-multi-wait-unsubmitted [63.995166] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [64.085809] [003/133] (960s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [64.176711] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [64.180610] Starting dynamic subtest: pipe-A-eDP-1 [64.189361] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [64.196830] Starting dynamic subtest: pipe-B-eDP-1 [64.206264] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [64.215101] Starting dynamic subtest: pipe-C-eDP-1 [64.223172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [64.229168] Starting dynamic subtest: pipe-D-eDP-1 [64.237408] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [64.241491] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s) [66.386276] [004/133] (958s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [66.436604] Starting subtest: y-tiled-ccs-to-yf-tiled [66.441084] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [66.621101] [005/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [66.814915] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [66.819468] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [66.946950] [006/133] (957s left) kms_big_fb (4-tiled-64bpp-rotate-180) [67.295646] Starting subtest: 4-tiled-64bpp-rotate-180 [69.050895] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.760s) [69.192174] [007/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [69.288465] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [69.293053] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [69.390307] [008/133] (955s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [69.487876] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [69.491251] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s) [69.558280] [009/133] (955s left) gem_exec_balancer (fairslice) [69.625231] Starting subtest: fairslice [72.527842] Subtest fairslice: SUCCESS (2.909s) [72.930551] [010/133] (951s left) kms_invalid_mode (bad-htotal) [73.023084] Starting subtest: bad-htotal [73.025460] Starting dynamic subtest: pipe-A-eDP-1 [73.305464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [73.314433] Starting dynamic subtest: pipe-B-eDP-1 [73.316720] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [73.323683] Starting dynamic subtest: pipe-C-eDP-1 [73.326062] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [73.333067] Starting dynamic subtest: pipe-D-eDP-1 [73.335016] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [73.336973] Subtest bad-htotal: SUCCESS (0.288s) [74.104336] [011/133] (950s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [74.216163] Starting subtest: yf-tiled-32bpp-rotate-180 [74.220845] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [74.320477] [012/133] (950s left) kms_content_protection (atomic-hdcp14) [74.463033] Starting subtest: atomic-hdcp14 [74.467703] Subtest atomic-hdcp14: SKIP (0.000s) [74.589200] [013/133] (950s left) i915_selftest (mock) [77.153894] Starting subtest: mock [77.156460] Starting dynamic subtest: sanitycheck [77.797350] Dynamic subtest sanitycheck: SUCCESS (0.644s) [77.806187] Starting dynamic subtest: shmem [78.478290] Dynamic subtest shmem: SUCCESS (0.680s) [78.487309] Starting dynamic subtest: fence [86.029239] Dynamic subtest fence: SUCCESS (7.545s) [86.037725] Starting dynamic subtest: scatterlist [87.681617] Dynamic subtest scatterlist: SUCCESS (1.651s) [87.694978] Starting dynamic subtest: syncmap [91.093444] Dynamic subtest syncmap: SUCCESS (3.409s) [91.101819] Starting dynamic subtest: uncore [91.735190] Dynamic subtest uncore: SUCCESS (0.641s) [91.743774] Starting dynamic subtest: ring [92.353271] Dynamic subtest ring: SUCCESS (0.617s) [92.362108] Starting dynamic subtest: engine [92.990643] Dynamic subtest engine: SUCCESS (0.636s) [92.999605] Starting dynamic subtest: timelines [96.816777] Dynamic subtest timelines: SUCCESS (3.824s) [96.825073] Starting dynamic subtest: requests [100.208036] Dynamic subtest requests: SUCCESS (3.389s) [100.216664] Starting dynamic subtest: objects [100.961327] Dynamic subtest objects: SUCCESS (0.753s) [100.970065] Starting dynamic subtest: phys [101.682990] Dynamic subtest phys: SUCCESS (0.720s) [101.691349] Starting dynamic subtest: dmabuf [102.400158] Dynamic subtest dmabuf: SUCCESS (0.717s) [102.410578] Starting dynamic subtest: vma [108.088971] Dynamic subtest vma: SUCCESS (5.674s) [108.097117] Starting dynamic subtest: evict [109.506352] Dynamic subtest evict: SUCCESS (1.429s) [109.514461] Starting dynamic subtest: gtt [112.847081] Dynamic subtest gtt: SUCCESS (3.340s) [112.855931] Starting dynamic subtest: hugepages [113.689378] Dynamic subtest hugepages: SUCCESS (0.842s) [113.698042] Starting dynamic subtest: memory_region [116.231349] Dynamic subtest memory_region: SUCCESS (2.540s) [116.234056] Subtest mock: SUCCESS (39.067s) [116.260142] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [116.263335] [014/133] (908s left) fbdev (unaligned-read) [117.782992] Starting subtest: unaligned-read [117.808575] Subtest unaligned-read: SUCCESS (0.027s) [117.847470] [FACT fbdev (unaligned-read)] new: kernel.kmod_is_loaded.i915: true [117.851475] [015/133] (906s left) perf_pmu (busy-accuracy-50) [117.894722] Starting subtest: busy-accuracy-50 [117.897126] Starting dynamic subtest: rcs0 [119.432925] Dynamic subtest rcs0: SUCCESS (1.535s) [119.443071] Starting dynamic subtest: bcs0 [120.986736] Dynamic subtest bcs0: SUCCESS (1.553s) [120.996534] Starting dynamic subtest: vcs0 [122.530443] Dynamic subtest vcs0: SUCCESS (1.542s) [122.540522] Starting dynamic subtest: vcs1 [124.076888] Dynamic subtest vcs1: SUCCESS (1.545s) [124.087032] Starting dynamic subtest: vecs0 [125.621284] Dynamic subtest vecs0: SUCCESS (1.543s) [125.631055] Starting dynamic subtest: ccs0 [127.167772] Dynamic subtest ccs0: SUCCESS (1.545s) [127.169893] Subtest busy-accuracy-50: SUCCESS (9.270s) [127.280955] [016/133] (897s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [127.381841] Starting subtest: plane-upscale-factor-0-25-with-rotation [127.384212] Starting dynamic subtest: pipe-A [127.618389] Dynamic subtest pipe-A: SUCCESS (0.238s) [127.626771] Starting dynamic subtest: pipe-B [128.922642] Dynamic subtest pipe-B: SUCCESS (1.303s) [128.935877] Starting dynamic subtest: pipe-C [130.255176] Dynamic subtest pipe-C: SUCCESS (1.332s) [130.265399] Starting dynamic subtest: pipe-D [131.596359] Dynamic subtest pipe-D: SUCCESS (1.341s) [131.598727] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.217s) [133.013323] [017/133] (891s left) gem_userptr_blits (sync-unmap-cycles) [133.101540] Starting subtest: sync-unmap-cycles [138.474995] Subtest sync-unmap-cycles: SUCCESS (5.374s) [138.581088] [018/133] (886s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [138.685858] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [138.689733] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [138.764609] [019/133] (886s left) gem_ctx_param (basic-default) [138.825362] Starting subtest: basic-default [138.827397] Subtest basic-default: SUCCESS (0.000s) [138.898133] [020/133] (886s left) syncobj_basic (bad-pad-handle-to-fd) [138.948914] Starting subtest: bad-pad-handle-to-fd [138.950558] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [139.071809] [021/133] (885s left) perf_pmu (render-node-busy-idle) [139.147021] Starting subtest: render-node-busy-idle [139.149055] Starting dynamic subtest: rcs0 [139.834910] Dynamic subtest rcs0: SUCCESS (0.687s) [139.845612] Starting dynamic subtest: bcs0 [140.498521] Dynamic subtest bcs0: SUCCESS (0.663s) [140.509294] Starting dynamic subtest: vcs0 [141.911577] Dynamic subtest vcs0: SUCCESS (1.409s) [141.922065] Starting dynamic subtest: vcs1 [143.895519] Dynamic subtest vcs1: SUCCESS (1.980s) [143.905586] Starting dynamic subtest: vecs0 [145.880253] Dynamic subtest vecs0: SUCCESS (1.982s) [145.891033] Starting dynamic subtest: ccs0 [146.548717] Dynamic subtest ccs0: SUCCESS (0.669s) [146.551213] Subtest render-node-busy-idle: SUCCESS (7.403s) [146.653438] [022/133] (878s left) kms_cursor_edge_walk (128x128-left-edge) [146.744882] Starting subtest: 128x128-left-edge [146.747235] Starting dynamic subtest: pipe-A-eDP-1 [150.180662] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s) [150.188835] Starting dynamic subtest: pipe-D-eDP-1 [153.293720] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s) [153.296052] Subtest 128x128-left-edge: SUCCESS (6.552s) [154.106412] [023/133] (871s left) kms_addfb_basic (unused-modifier) [154.170221] Starting subtest: unused-modifier [154.172496] Subtest unused-modifier: SUCCESS (0.000s) [154.314497] [024/133] (870s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [154.404603] Starting subtest: fbc-farfromfence-mmap-gtt [154.409066] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [154.483334] [025/133] (870s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [154.580523] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [155.382895] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.804s) [155.554059] [026/133] (869s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [155.613735] Starting subtest: mixed-tiled-to-yf-tiled-ccs [155.618388] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [155.809681] [027/133] (869s left) kms_lease (lease-revoke) [155.893085] Starting subtest: lease-revoke [155.895444] Starting dynamic subtest: pipe-A-eDP-1 [155.921417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s) [155.932809] Starting dynamic subtest: pipe-B-eDP-1 [155.950885] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s) [155.961110] Starting dynamic subtest: pipe-C-eDP-1 [155.979808] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s) [155.987604] Starting dynamic subtest: pipe-D-eDP-1 [156.004854] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s) [156.007117] Subtest lease-revoke: SUCCESS (0.114s) [156.129023] [028/133] (869s left) kms_properties (colorop-properties-atomic) [156.214131] Starting subtest: colorop-properties-atomic [156.216500] Starting dynamic subtest: pipe-A-eDP-1 [156.547436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.333s) [156.555550] Starting dynamic subtest: pipe-B-eDP-1 [157.584479] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.036s) [157.593315] Starting dynamic subtest: pipe-C-eDP-1 [158.620148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.035s) [158.629902] Starting dynamic subtest: pipe-D-eDP-1 [159.653340] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.030s) [159.655738] Subtest colorop-properties-atomic: SUCCESS (3.438s) [160.444854] [029/133] (864s left) gem_exec_whisper (basic-forked-all) [160.514719] Starting subtest: basic-forked-all [173.854716] Subtest basic-forked-all: SUCCESS (13.340s) [174.067732] [030/133] (851s left) syncobj_timeline (signal-array) [174.122274] Starting subtest: signal-array [174.124667] Subtest signal-array: SUCCESS (0.000s) [174.219787] [031/133] (851s left) kms_flip (2x-busy-flip) [174.311205] Starting subtest: 2x-busy-flip [174.319446] Subtest 2x-busy-flip: SKIP (0.010s) [174.408291] [032/133] (851s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [174.508687] Starting subtest: fbc-rgb565-draw-mmap-gtt [174.513280] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [174.608976] [033/133] (850s left) kms_psr (psr2-primary-render) [174.704343] Starting subtest: psr2-primary-render [174.706646] Starting dynamic subtest: eDP-1 [176.429673] Dynamic subtest eDP-1: SUCCESS (1.726s) [176.431850] Subtest psr2-primary-render: SUCCESS (1.727s) [177.298536] [034/133] (848s left) gem_exec_reloc (basic-wc-cpu) [177.358992] Subtest basic-wc-cpu: SKIP (0.000s) [177.439048] [035/133] (848s left) kms_cursor_legacy (flip-vs-cursor-toggle) [177.546322] Starting subtest: flip-vs-cursor-toggle [186.075841] Subtest flip-vs-cursor-toggle: SUCCESS (8.527s) [186.921739] [036/133] (838s left) kms_getfb (getfb-reject-nv12) [187.005070] Starting subtest: getfb-reject-nv12 [187.007434] Subtest getfb-reject-nv12: SUCCESS (0.001s) [187.101325] [037/133] (838s left) kms_sequence (get-forked-busy) [187.192205] Starting subtest: get-forked-busy [187.194474] Starting dynamic subtest: pipe-A-eDP-1 [189.119356] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.926s) [189.128926] Starting dynamic subtest: pipe-B-eDP-1 [191.710594] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.591s) [191.720875] Starting dynamic subtest: pipe-C-eDP-1 [194.337756] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s) [194.346907] Starting dynamic subtest: pipe-D-eDP-1 [196.965933] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s) [196.968380] Subtest get-forked-busy: SUCCESS (9.775s) [197.784368] [038/133] (827s left) gen7_exec_parse (basic-rejected) [197.842277] Subtest basic-rejected: SKIP (0.000s) [197.911717] [039/133] (827s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [198.042041] Starting subtest: cursorA-vs-flipA-varying-size [209.181348] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.136s) [209.985083] [040/133] (815s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [210.050531] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [210.155296] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s) [210.232380] [041/133] (815s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [210.374698] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [221.551949] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.175s) [222.432167] [042/133] (803s left) kms_cursor_crc (cursor-rapid-movement-max-size) [222.775442] Starting subtest: cursor-rapid-movement-max-size [222.781958] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [222.888532] [043/133] (803s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [222.979078] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [223.005298] Starting dynamic subtest: pipe-A-plane-0 [223.660444] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s) [223.672515] Starting dynamic subtest: pipe-A-plane-3 [224.048955] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s) [225.113363] Starting dynamic subtest: pipe-B-plane-0 [225.762037] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s) [225.770052] Starting dynamic subtest: pipe-B-plane-3 [226.206062] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s) [226.515757] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.536s) [227.385438] [044/133] (798s left) i915_drm_fdinfo (virtual-busy-all) [227.439108] Starting subtest: virtual-busy-all [227.443988] Subtest virtual-busy-all: SKIP (0.000s) [227.522597] [045/133] (798s left) syncobj_basic (bad-fd-to-handle) [227.575594] Starting subtest: bad-fd-to-handle [227.577519] Subtest bad-fd-to-handle: SUCCESS (0.000s) [227.682761] [046/133] (798s left) sriov_basic (enable-vfs-bind-unbind-each) [227.733210] Starting subtest: enable-vfs-bind-unbind-each [227.735514] Starting dynamic subtest: numvfs-1 [227.819528] Dynamic subtest numvfs-1: FAIL (0.034s) [227.829519] Starting dynamic subtest: numvfs-2 [227.902694] Dynamic subtest numvfs-2: FAIL (0.004s) [227.912071] Starting dynamic subtest: numvfs-3 [227.984279] Dynamic subtest numvfs-3: FAIL (0.004s) [227.993634] Starting dynamic subtest: numvfs-4 [228.075546] Dynamic subtest numvfs-4: FAIL (0.004s) [228.084698] Starting dynamic subtest: numvfs-5 [228.156708] Dynamic subtest numvfs-5: FAIL (0.004s) [228.166869] Starting dynamic subtest: numvfs-6 [228.240912] Dynamic subtest numvfs-6: FAIL (0.004s) [228.250157] Starting dynamic subtest: numvfs-7 [228.321390] Dynamic subtest numvfs-7: FAIL (0.007s) [228.330509] Starting dynamic subtest: numvfs-random [228.389688] Dynamic subtest numvfs-random: FAIL (0.003s) [228.391836] Subtest enable-vfs-bind-unbind-each: FAIL (0.070s) [228.429296] [047/133] (797s left) kms_chamelium_hpd (dp-hpd) [228.812206] Subtest dp-hpd: SKIP (0.000s) [229.587934] [048/133] (796s left) gem_exec_whisper (basic-queues-priority) [229.651629] Starting subtest: basic-queues-priority [254.018975] Subtest basic-queues-priority: SUCCESS (24.361s) [254.214751] [049/133] (771s left) api_intel_allocator (reserve-simple) [254.274485] Starting subtest: reserve-simple [254.278830] Subtest reserve-simple: SUCCESS (0.007s) [254.409273] [050/133] (771s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [254.514972] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [254.517263] Starting dynamic subtest: pipe-A-eDP-1 [254.538379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [254.548308] Starting dynamic subtest: pipe-B-eDP-1 [254.567826] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [254.575813] Starting dynamic subtest: pipe-C-eDP-1 [254.594922] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [254.602765] Starting dynamic subtest: pipe-D-eDP-1 [254.621929] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [254.624079] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [256.756677] [051/133] (769s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [256.852612] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [256.856647] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [256.945871] [052/133] (769s left) gem_exec_fence (basic-await) [257.117598] Starting subtest: basic-await [257.120364] Starting dynamic subtest: rcs0 [257.192910] Dynamic subtest rcs0: SUCCESS (0.075s) [257.205170] Starting dynamic subtest: bcs0 [257.266991] Dynamic subtest bcs0: SUCCESS (0.072s) [257.278072] Starting dynamic subtest: vcs0 [257.339046] Dynamic subtest vcs0: SUCCESS (0.070s) [257.350443] Starting dynamic subtest: vcs1 [257.411173] Dynamic subtest vcs1: SUCCESS (0.071s) [257.423034] Starting dynamic subtest: vecs0 [257.484234] Dynamic subtest vecs0: SUCCESS (0.071s) [257.496093] Starting dynamic subtest: ccs0 [257.557115] Dynamic subtest ccs0: SUCCESS (0.071s) [257.559666] Subtest basic-await: SUCCESS (0.441s) [258.982378] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true [258.985938] [053/133] (767s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [259.084659] Starting subtest: fbcpsr-rgb101010-draw-pwrite [266.041998] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.959s) [266.146115] [054/133] (760s left) kms_psr (pr-suspend) [266.248302] Starting subtest: pr-suspend [266.252238] Subtest pr-suspend: SKIP (0.000s) [266.335466] [055/133] (760s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [266.432349] Starting subtest: multiplane-rotation-cropping-bottom [283.831508] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.406s) [283.951272] [056/133] (742s left) kms_vblank (ts-continuation-dpms-suspend) [284.056409] Starting subtest: ts-continuation-dpms-suspend [284.058150] Starting dynamic subtest: pipe-A-eDP-1 [301.713864] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.032s) [301.728864] Starting dynamic subtest: pipe-D-eDP-1 [319.689884] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s) [319.691803] Subtest ts-continuation-dpms-suspend: SUCCESS (4.582s) [320.473214] [057/133] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [320.582761] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [326.951026] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.541s) [327.059730] [058/133] (699s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [327.147642] Starting subtest: compare-crc-sanitycheck-nv12 [327.149884] Starting dynamic subtest: pipe-A-eDP-1 [327.778656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s) [327.797309] Starting dynamic subtest: pipe-B-eDP-1 [329.103677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s) [329.113237] Starting dynamic subtest: pipe-C-eDP-1 [330.377890] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.286s) [330.387159] Starting dynamic subtest: pipe-D-eDP-1 [331.591957] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s) [331.593859] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.500s) [332.385777] [059/133] (694s left) gem_media_fill (media-fill) [332.457337] Subtest media-fill: SKIP (0.000s) [332.550630] [060/133] (694s left) gem_pread (self) [332.609354] Subtest self: SKIP (0.000s) [332.665295] [061/133] (693s left) kms_color_pipeline (plane-ctm3x4) [332.766496] Starting subtest: plane-ctm3x4 [332.911786] Starting dynamic subtest: pipe-A-plane-0 [333.032769] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s) [333.043771] Starting dynamic subtest: pipe-A-plane-1 [333.153534] Dynamic subtest pipe-A-plane-1: SUCCESS (0.121s) [333.163662] Starting dynamic subtest: pipe-A-plane-2 [333.285892] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s) [334.467902] Starting dynamic subtest: pipe-B-plane-0 [334.612755] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s) [334.622843] Starting dynamic subtest: pipe-B-plane-1 [334.723283] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s) [334.732574] Starting dynamic subtest: pipe-B-plane-2 [334.834514] Dynamic subtest pipe-B-plane-2: SUCCESS (0.110s) [335.983976] Starting dynamic subtest: pipe-C-plane-0 [336.087047] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s) [336.103400] Starting dynamic subtest: pipe-C-plane-1 [336.210024] Dynamic subtest pipe-C-plane-1: SUCCESS (0.121s) [336.219529] Starting dynamic subtest: pipe-C-plane-2 [336.340247] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s) [337.531684] Starting dynamic subtest: pipe-D-plane-0 [337.645791] Dynamic subtest pipe-D-plane-0: SUCCESS (0.122s) [337.655541] Starting dynamic subtest: pipe-D-plane-1 [337.767588] Dynamic subtest pipe-D-plane-1: SUCCESS (0.122s) [337.777348] Starting dynamic subtest: pipe-D-plane-2 [337.889193] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s) [338.175782] Subtest plane-ctm3x4: SUCCESS (5.440s) [338.974477] [062/133] (687s left) gem_exec_alignment (many) [339.036751] Starting subtest: many [362.335207] Subtest many: SUCCESS (23.304s) [364.930871] [063/133] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [365.077904] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [365.082005] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [365.173884] [064/133] (661s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [365.259468] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [365.261792] Starting dynamic subtest: pipe-A [365.623539] Dynamic subtest pipe-A: SUCCESS (0.365s) [365.636726] Starting dynamic subtest: pipe-B [367.088750] Dynamic subtest pipe-B: SUCCESS (1.463s) [367.098507] Starting dynamic subtest: pipe-C [368.533232] Dynamic subtest pipe-C: SUCCESS (1.443s) [368.549018] Starting dynamic subtest: pipe-D [369.935748] Dynamic subtest pipe-D: SUCCESS (1.400s) [369.937998] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.678s) [371.081146] [065/133] (655s left) gem_exec_schedule (preemptive-hang) [371.271196] Starting subtest: preemptive-hang [371.274021] Starting dynamic subtest: rcs0 [380.221175] Dynamic subtest rcs0: SUCCESS (8.948s) [380.231779] Starting dynamic subtest: bcs0 [389.172621] Dynamic subtest bcs0: SUCCESS (8.951s) [389.184195] Starting dynamic subtest: vcs0 [398.197119] Dynamic subtest vcs0: SUCCESS (9.024s) [398.209404] Starting dynamic subtest: vcs1 [407.155969] Dynamic subtest vcs1: SUCCESS (8.958s) [407.165307] Starting dynamic subtest: vecs0 [416.175232] Dynamic subtest vecs0: SUCCESS (9.017s) [416.187270] Starting dynamic subtest: ccs0 [425.207052] Dynamic subtest ccs0: SUCCESS (9.026s) [425.209655] Subtest preemptive-hang: SUCCESS (53.934s) [425.436429] [066/133] (601s left) gem_ctx_persistence (engines-hang) [425.499675] Starting subtest: engines-hang [425.502231] Starting dynamic subtest: rcs0 [425.570768] Dynamic subtest rcs0: SUCCESS (0.070s) [425.583320] Starting dynamic subtest: bcs0 [425.641222] Dynamic subtest bcs0: SUCCESS (0.069s) [425.651258] Starting dynamic subtest: vcs0 [425.763316] Dynamic subtest vcs0: SUCCESS (0.120s) [425.775511] Starting dynamic subtest: vcs1 [425.857531] Dynamic subtest vcs1: SUCCESS (0.092s) [425.869306] Starting dynamic subtest: vecs0 [425.947099] Dynamic subtest vecs0: SUCCESS (0.088s) [425.958501] Starting dynamic subtest: ccs0 [426.038990] Dynamic subtest ccs0: SUCCESS (0.090s) [426.041372] Subtest engines-hang: SUCCESS (0.540s) [426.118975] [067/133] (600s left) gem_exec_schedule (deep) [426.294263] Starting subtest: deep [426.296806] Starting dynamic subtest: rcs0 [432.345466] Dynamic subtest rcs0: SKIP (6.048s) [432.357261] Starting dynamic subtest: vcs0 [442.919354] Dynamic subtest vcs0: SUCCESS (10.572s) [442.932397] Starting dynamic subtest: vcs1 [454.463549] Dynamic subtest vcs1: SUCCESS (11.543s) [454.474747] Starting dynamic subtest: vecs0 [465.422466] Dynamic subtest vecs0: SUCCESS (10.958s) [465.438056] Starting dynamic subtest: ccs0 [477.650036] Dynamic subtest ccs0: SUCCESS (12.227s) [477.652663] Subtest deep: SUCCESS (51.354s) [478.786673] [068/133] (548s left) gem_wait (busy) [478.844921] Starting subtest: busy [478.847122] Starting dynamic subtest: all-engines [480.078660] Dynamic subtest all-engines: SUCCESS (1.232s) [480.091262] Starting dynamic subtest: rcs0 [480.621407] Dynamic subtest rcs0: SUCCESS (0.541s) [480.634489] Starting dynamic subtest: bcs0 [481.161520] Dynamic subtest bcs0: SUCCESS (0.540s) [481.176316] Starting dynamic subtest: vcs0 [483.102199] Dynamic subtest vcs0: SUCCESS (1.921s) [483.113321] Starting dynamic subtest: vcs1 [485.070046] Dynamic subtest vcs1: SUCCESS (1.983s) [485.083154] Starting dynamic subtest: vecs0 [487.053232] Dynamic subtest vecs0: SUCCESS (1.981s) [487.066102] Starting dynamic subtest: ccs0 [487.594756] Dynamic subtest ccs0: SUCCESS (0.540s) [487.597280] Subtest busy: SUCCESS (8.751s) [487.792972] [069/133] (539s left) gem_madvise (dontneed-before-mmap) [487.835275] Starting subtest: dontneed-before-mmap [487.854007] Subtest dontneed-before-mmap: SUCCESS (0.021s) [487.955160] [070/133] (539s left) gem_exec_flush (basic-uc-rw-default) [488.024977] Starting subtest: basic-uc-rw-default [493.507264] Subtest basic-uc-rw-default: SUCCESS (5.485s) [493.707445] [071/133] (533s left) gem_mmap_gtt (basic) [493.767573] Subtest basic: SKIP (0.000s) [493.825878] [072/133] (533s left) kms_tv_load_detect (load-detect) [493.873825] Subtest load-detect: SKIP (0.000s) [493.949381] [073/133] (533s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [494.053959] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [494.058364] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [494.158078] [074/133] (533s left) gem_wait (invalid-buf) [494.223658] Starting subtest: invalid-buf [494.225821] Subtest invalid-buf: SUCCESS (0.000s) [494.424256] [075/133] (532s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [494.519848] Starting subtest: bad-aux-stride-y-tiled-ccs [494.522207] Starting dynamic subtest: pipe-A-eDP-1 [494.547007] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [494.558104] Starting dynamic subtest: pipe-B-eDP-1 [494.579802] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [494.589016] Starting dynamic subtest: pipe-C-eDP-1 [494.610099] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [494.619095] Starting dynamic subtest: pipe-D-eDP-1 [494.641253] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [494.645366] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s) [496.844984] [076/133] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [496.948208] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [496.952740] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [497.045075] [077/133] (530s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [497.150039] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [497.154109] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [497.243111] [078/133] (530s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [497.338133] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [503.871461] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.537s) [503.970890] [079/133] (523s left) kms_properties (invalid-properties-legacy) [504.060513] Starting subtest: invalid-properties-legacy [504.167743] Subtest invalid-properties-legacy: SUCCESS (0.108s) [504.238915] [080/133] (523s left) gem_mmap_gtt (basic-read-write-distinct) [504.292087] Subtest basic-read-write-distinct: SKIP (0.000s) [504.359359] [081/133] (523s left) kms_display_modes (extended-mode-basic) [504.452800] Starting subtest: extended-mode-basic [504.456884] Subtest extended-mode-basic: SKIP (0.000s) [504.499267] [082/133] (522s left) kms_flip (blocking-absolute-wf_vblank) [504.595687] Starting subtest: blocking-absolute-wf_vblank [504.597572] Starting dynamic subtest: A-eDP1 [513.378278] Dynamic subtest A-eDP1: SUCCESS (8.786s) [513.391792] Starting dynamic subtest: B-eDP1 [522.109267] Dynamic subtest B-eDP1: SUCCESS (8.730s) [522.121151] Starting dynamic subtest: C-eDP1 [530.832684] Dynamic subtest C-eDP1: SUCCESS (8.721s) [530.845311] Starting dynamic subtest: D-eDP1 [539.565175] Dynamic subtest D-eDP1: SUCCESS (8.733s) [539.570526] Subtest blocking-absolute-wf_vblank: SUCCESS (34.982s) [540.797424] [083/133] (486s left) kms_psr2_su (page_flip-xrgb8888) [540.875497] Subtest page_flip-XRGB8888: SKIP (0.000s) [540.938980] [084/133] (486s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [541.004997] Starting subtest: multi-wait-for-submit-available-submitted [541.007274] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [541.097764] [085/133] (486s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [541.202645] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [541.210894] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s) [541.287781] [086/133] (486s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [541.369632] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [541.373675] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [541.440421] [087/133] (486s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [541.551788] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [541.554124] Starting dynamic subtest: pipe-A-eDP-1 [541.579749] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [541.590817] Starting dynamic subtest: pipe-B-eDP-1 [541.614747] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [541.625522] Starting dynamic subtest: pipe-C-eDP-1 [541.649243] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [541.658884] Starting dynamic subtest: pipe-D-eDP-1 [541.683172] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [541.687687] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s) [543.838296] [088/133] (483s left) kms_chamelium_frames (hdmi-frame-dump) [544.235305] Subtest hdmi-frame-dump: SKIP (0.000s) [545.045876] [089/133] (482s left) gem_mmap_offset (mmap-unmap) [545.099371] Starting subtest: mmap-unmap [545.101551] Starting dynamic subtest: smem0 [567.792207] Dynamic subtest smem0: SUCCESS (22.688s) [567.794923] Subtest mmap-unmap: SUCCESS (22.689s) [567.908865] [090/133] (459s left) i915_module_load (reload) [567.951319] Starting subtest: reload [571.264548] Subtest reload: SUCCESS (3.315s) [571.303571] [091/133] (456s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [573.046608] Starting subtest: flip-vs-cursor-busy-crc-atomic [573.876180] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.830s) [574.710715] [092/133] (453s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [574.798629] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [574.801019] Starting dynamic subtest: pipe-A-eDP-1 [574.859133] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [574.867462] Starting dynamic subtest: pipe-B-eDP-1 [574.923144] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [574.933110] Starting dynamic subtest: pipe-C-eDP-1 [574.989155] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [574.999023] Starting dynamic subtest: pipe-D-eDP-1 [575.056354] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [575.061525] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s) [577.088956] [093/133] (450s left) kms_psr (fbc-psr-cursor-render) [577.185670] Starting subtest: fbc-psr-cursor-render [577.188056] Starting dynamic subtest: eDP-1 [577.192582] Dynamic subtest eDP-1: SKIP (0.000s) [577.197142] Subtest fbc-psr-cursor-render: SKIP (0.001s) [577.256317] [094/133] (450s left) kms_dsc (dsc-basic) [577.341036] Starting subtest: dsc-basic [577.354468] Subtest dsc-basic: SKIP (0.000s) [577.416988] [095/133] (450s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [577.526111] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [586.778329] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.254s) [586.929764] [096/133] (441s left) kms_flip (flip-vs-dpms-on-nop) [587.030821] Starting subtest: flip-vs-dpms-on-nop [587.033048] Starting dynamic subtest: A-eDP1 [588.922260] Dynamic subtest A-eDP1: SUCCESS (1.893s) [588.931397] Starting dynamic subtest: B-eDP1 [590.747289] Dynamic subtest B-eDP1: SUCCESS (1.822s) [590.758234] Starting dynamic subtest: C-eDP1 [592.560505] Dynamic subtest C-eDP1: SUCCESS (1.813s) [592.570039] Starting dynamic subtest: D-eDP1 [594.384008] Dynamic subtest D-eDP1: SUCCESS (1.822s) [594.386535] Subtest flip-vs-dpms-on-nop: SUCCESS (7.359s) [595.582265] [097/133] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [595.679870] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [595.684479] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [595.762174] [098/133] (432s left) gem_exec_schedule (promotion) [595.842092] Starting subtest: promotion [595.844100] Starting dynamic subtest: rcs0 [595.948483] Dynamic subtest rcs0: SUCCESS (0.111s) [595.960910] Starting dynamic subtest: vcs0 [596.036060] Dynamic subtest vcs0: SUCCESS (0.087s) [596.048333] Starting dynamic subtest: vcs1 [596.118834] Dynamic subtest vcs1: SUCCESS (0.081s) [596.137596] Starting dynamic subtest: vecs0 [596.199086] Dynamic subtest vecs0: SUCCESS (0.079s) [596.212807] Starting dynamic subtest: ccs0 [596.291162] Dynamic subtest ccs0: SUCCESS (0.092s) [596.293945] Subtest promotion: SUCCESS (0.455s) [597.164019] [099/133] (431s left) syncobj_wait (multi-wait-all-signaled) [597.226036] Starting subtest: multi-wait-all-signaled [597.228353] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [597.343263] [100/133] (430s left) gem_mmap_gtt (basic-write-gtt) [597.411095] Subtest basic-write-gtt: SKIP (0.000s) [597.512907] [101/133] (430s left) gem_sync (basic-store-all) [597.596062] Starting subtest: basic-store-all [601.750787] Subtest basic-store-all: SUCCESS (4.165s) [601.953271] [102/133] (426s left) kms_addfb_basic (legacy-format) [602.012072] Starting subtest: legacy-format [602.031338] Subtest legacy-format: SUCCESS (0.020s) [602.179531] [103/133] (426s left) syncobj_timeline (32bits-limit) [602.231635] Starting subtest: 32bits-limit [602.233923] Subtest 32bits-limit: SUCCESS (0.001s) [602.324207] [104/133] (426s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [602.435233] Starting subtest: fbcpsr-stridechange [608.666513] Subtest fbcpsr-stridechange: SUCCESS (6.234s) [608.815341] [105/133] (419s left) kms_prime (basic-modeset-hybrid) [608.903201] Subtest basic-modeset-hybrid: SKIP (0.000s) [609.007175] [106/133] (419s left) kms_pm_rpm (dpms-lpsp) [611.239182] Starting subtest: dpms-lpsp [611.556364] Subtest dpms-lpsp: SUCCESS (0.319s) [611.664842] [107/133] (416s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [611.790916] Starting subtest: cursor-vs-flip-varying-size [642.562824] Subtest cursor-vs-flip-varying-size: SUCCESS (30.772s) [643.454059] [108/133] (385s left) kms_addfb_basic (clobberred-modifier) [643.514119] Starting subtest: clobberred-modifier [643.518758] Subtest clobberred-modifier: SKIP (0.000s) [643.650403] [109/133] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [643.746207] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [643.750575] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [643.849867] [110/133] (384s left) kms_cursor_crc (cursor-onscreen-32x10) [644.018106] Starting subtest: cursor-onscreen-32x10 [644.071713] Subtest cursor-onscreen-32x10: SKIP (0.049s) [644.320598] [111/133] (384s left) api_intel_bb (object-reloc-keep-cache) [644.386550] Starting subtest: object-reloc-keep-cache [644.390496] Subtest object-reloc-keep-cache: SKIP (0.002s) [644.475225] [112/133] (384s left) gem_exec_create (basic) [644.537475] Starting subtest: basic [644.539321] Starting dynamic subtest: smem [648.012490] Dynamic subtest smem: SUCCESS (3.475s) [648.014329] Subtest basic: SUCCESS (3.477s) [648.202890] [113/133] (380s left) gem_exec_fence (parallel) [648.394724] Starting subtest: parallel [648.397707] Starting dynamic subtest: rcs0 [650.549986] Dynamic subtest rcs0: SUCCESS (2.155s) [650.566271] Starting dynamic subtest: bcs0 [652.703048] Dynamic subtest bcs0: SUCCESS (2.152s) [652.714028] Starting dynamic subtest: vcs0 [654.853822] Dynamic subtest vcs0: SUCCESS (2.150s) [654.863907] Starting dynamic subtest: vcs1 [657.008533] Dynamic subtest vcs1: SUCCESS (2.154s) [657.018715] Starting dynamic subtest: vecs0 [659.157883] Dynamic subtest vecs0: SUCCESS (2.148s) [659.171970] Starting dynamic subtest: ccs0 [661.307596] Dynamic subtest ccs0: SUCCESS (2.148s) [661.309576] Subtest parallel: SUCCESS (12.914s) [662.106430] [114/133] (366s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [662.198359] Starting subtest: pr-primary-plane-update-sf-dmg-area [662.202883] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [662.266948] [115/133] (366s left) kms_psr (fbc-pr-sprite-render) [662.358494] Starting subtest: fbc-pr-sprite-render [662.362853] Subtest fbc-pr-sprite-render: SKIP (0.000s) [662.431892] [116/133] (366s left) i915_pm_rpm (gem-evict-pwrite) [664.264640] Starting subtest: gem-evict-pwrite [664.269320] Subtest gem-evict-pwrite: SKIP (0.000s) [664.668260] [117/133] (364s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [664.757234] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [664.761698] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [664.860832] [118/133] (364s left) core_getversion (all-cards) [664.903331] Starting subtest: all-cards [664.910928] Subtest all-cards: SUCCESS (0.011s) [664.953967] [119/133] (364s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [665.048477] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [665.052370] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [665.155223] [120/133] (363s left) gem_eio (wait-10ms) [665.374346] Starting subtest: wait-10ms [665.747280] Subtest wait-10ms: SUCCESS (0.371s) [665.896167] [121/133] (363s left) kms_big_fb (y-tiled-8bpp-rotate-90) [665.997554] Starting subtest: y-tiled-8bpp-rotate-90 [666.002194] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [666.098408] [122/133] (363s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [666.226768] Starting subtest: 2x-long-cursor-vs-flip-atomic [666.231256] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [666.371990] [123/133] (362s left) gem_eio (throttle) [666.603132] Starting subtest: throttle [666.930297] Subtest throttle: SUCCESS (0.325s) [667.089838] [124/133] (362s left) gem_ctx_exec (basic-invalid-context) [667.140646] Starting subtest: basic-invalid-context [667.145250] Subtest basic-invalid-context: SUCCESS (0.005s) [667.261365] [125/133] (362s left) gem_softpin (allocator-evict) [667.339424] Starting subtest: allocator-evict [667.341389] Starting dynamic subtest: rcs0 [690.990409] Dynamic subtest rcs0: SUCCESS (23.652s) [691.001621] Starting dynamic subtest: bcs0 [714.572083] Dynamic subtest bcs0: SUCCESS (23.582s) [714.584463] Starting dynamic subtest: vcs0 [738.506864] Dynamic subtest vcs0: SUCCESS (23.936s) [738.518668] Starting dynamic subtest: vcs1 [762.073411] Dynamic subtest vcs1: SUCCESS (23.568s) [762.086221] Starting dynamic subtest: vecs0 [785.951799] Dynamic subtest vecs0: SUCCESS (23.879s) [785.963898] Starting dynamic subtest: ccs0 [809.741143] Dynamic subtest ccs0: SUCCESS (23.787s) [809.743636] Subtest allocator-evict: SUCCESS (142.412s) [809.824066] [126/133] (219s left) gem_mmap_wc (read) [809.923047] Subtest read: SKIP (0.000s) [809.988667] [127/133] (219s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [810.103524] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [810.107767] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [810.195337] [128/133] (219s left) gem_linear_blits (normal) [810.360260] Starting subtest: normal [814.519422] Subtest normal: SUCCESS (4.161s) [814.652892] [129/133] (214s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [814.799483] Starting subtest: modeset-transition-nonblocking-fencing [814.801487] Starting dynamic subtest: 1x-outputs [825.933177] Dynamic subtest 1x-outputs: SUCCESS (11.133s) [825.936220] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.134s) [826.791009] [130/133] (202s left) gen3_render_tiledx_blits [826.910769] [131/133] (202s left) gem_gtt_cpu_tlb [827.031411] [132/133] (202s left) sysfs_timeslice_duration (duration) [827.096299] Starting subtest: duration [827.098483] Starting dynamic subtest: vecs0 [841.005893] Dynamic subtest vecs0: SUCCESS (13.907s) [841.018790] Starting dynamic subtest: ccs0 [854.164170] Dynamic subtest ccs0: SUCCESS (13.153s) [854.176337] Starting dynamic subtest: vcs0 [868.012172] Dynamic subtest vcs0: SUCCESS (13.842s) [868.025122] Starting dynamic subtest: bcs0 [881.160500] Dynamic subtest bcs0: SUCCESS (13.145s) [881.174102] Starting dynamic subtest: rcs0 [894.316631] Dynamic subtest rcs0: SUCCESS (13.153s) [894.329019] Starting dynamic subtest: vcs1 [909.038092] Dynamic subtest vcs1: SUCCESS (14.716s) [909.040980] Subtest duration: SUCCESS (81.934s) [909.141147] [133/133] (120s left) gem_ctx_persistence (legacy-engines-queued) [909.201784] Starting subtest: legacy-engines-queued [909.204172] Starting dynamic subtest: render [909.273670] Dynamic subtest render: SUCCESS (0.072s) [909.285660] Starting dynamic subtest: bsd1 [911.023195] Dynamic subtest bsd1: SUCCESS (1.746s) [911.034205] Starting dynamic subtest: bsd2 [913.003217] Dynamic subtest bsd2: SUCCESS (1.976s) [913.016276] Starting dynamic subtest: blt [913.056251] Dynamic subtest blt: SUCCESS (0.051s) [913.067985] Starting dynamic subtest: vebox [915.052503] Dynamic subtest vebox: SUCCESS (1.993s) [915.055494] Subtest legacy-engines-queued: SUCCESS (5.851s) [915.131019] Closing watchdogs results: parsing output: 0/ for test: gem_exec_reloc results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: gem_render_copy results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_flip_scaled_crc results: parsing output: 8/ for test: gem_exec_balancer results: parsing output: 9/ for test: kms_invalid_mode results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_content_protection results: parsing output: 12/ for test: i915_selftest results: parsing output: 13/ for test: fbdev results: parsing output: 14/ for test: perf_pmu results: parsing output: 15/ for test: kms_plane_scaling results: parsing output: 16/ for test: gem_userptr_blits results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: gem_ctx_param results: parsing output: 19/ for test: syncobj_basic results: parsing output: 20/ for test: perf_pmu results: parsing output: 21/ for test: kms_cursor_edge_walk results: parsing output: 22/ for test: kms_addfb_basic results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: gem_render_copy results: parsing output: 26/ for test: kms_lease results: parsing output: 27/ for test: kms_properties results: parsing output: 28/ for test: gem_exec_whisper results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: gem_exec_reloc results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: kms_getfb results: parsing output: 36/ for test: kms_sequence results: parsing output: 37/ for test: gen7_exec_parse results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_cursor_legacy results: parsing output: 41/ for test: kms_cursor_crc results: parsing output: 42/ for test: kms_plane results: parsing output: 43/ for test: i915_drm_fdinfo results: parsing output: 44/ for test: syncobj_basic results: parsing output: 45/ for test: sriov_basic results: parsing output: 46/ for test: kms_chamelium_hpd results: parsing output: 47/ for test: gem_exec_whisper results: parsing output: 48/ for test: api_intel_allocator results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_exec_fence results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_vblank results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_pipe_crc_basic results: parsing output: 58/ for test: gem_media_fill results: parsing output: 59/ for test: gem_pread results: parsing output: 60/ for test: kms_color_pipeline results: parsing output: 61/ for test: gem_exec_alignment results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_plane_scaling results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: gem_ctx_persistence results: parsing output: 66/ for test: gem_exec_schedule results: parsing output: 67/ for test: gem_wait results: parsing output: 68/ for test: gem_madvise results: parsing output: 69/ for test: gem_exec_flush results: parsing output: 70/ for test: gem_mmap_gtt results: parsing output: 71/ for test: kms_tv_load_detect results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: gem_wait results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_properties results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: kms_display_modes results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_psr2_su results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_flip results: parsing output: 85/ for test: kms_plane results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: kms_chamelium_frames results: parsing output: 88/ for test: gem_mmap_offset results: parsing output: 89/ for test: i915_module_load results: parsing output: 90/ for test: kms_cursor_legacy results: parsing output: 91/ for test: kms_ccs results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: kms_dsc results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: syncobj_wait results: parsing output: 99/ for test: gem_mmap_gtt results: parsing output: 100/ for test: gem_sync results: parsing output: 101/ for test: kms_addfb_basic results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_prime results: parsing output: 105/ for test: kms_pm_rpm results: parsing output: 106/ for test: kms_cursor_legacy results: parsing output: 107/ for test: kms_addfb_basic results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_cursor_crc results: parsing output: 110/ for test: api_intel_bb results: parsing output: 111/ for test: gem_exec_create results: parsing output: 112/ for test: gem_exec_fence results: parsing output: 113/ for test: kms_psr2_sf results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: i915_pm_rpm results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: core_getversion results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_eio results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: gem_eio results: parsing output: 123/ for test: gem_ctx_exec results: parsing output: 124/ for test: gem_softpin results: parsing output: 125/ for test: gem_mmap_wc results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: gem_linear_blits results: parsing output: 128/ for test: kms_atomic_transition results: parsing output: 129/ for test: gen3_render_tiledx_blits results: parsing output: 130/ for test: gem_gtt_cpu_tlb results: parsing output: 131/ for test: sysfs_timeslice_duration results: parsing output: 132/ for test: gem_ctx_persistence Done.