[56.463032] Initializing watchdogs [56.463158] /dev/watchdog0 [56.478233] [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] [56.482341] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.484600] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.487763] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [56.611428] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [56.615773] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [56.735931] [002/131] (960s left) gem_exec_fence (submit3) [56.912268] Starting subtest: submit3 [56.917119] Subtest submit3: SKIP (0.000s) [59.041197] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [59.044158] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [59.153564] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [59.158082] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.302061] [004/131] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [59.400998] Starting subtest: fbc-rgb101010-draw-mmap-wc [63.958827] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.559s) [65.096632] [005/131] (952s left) gem_exec_balancer (noheartbeat) [65.363388] Starting subtest: noheartbeat [65.368575] Subtest noheartbeat: SKIP (0.000s) [65.489871] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [65.582979] Subtest ctm-blue-to-red: SKIP (0.000s) [65.627227] [007/131] (951s left) gem_workarounds (suspend-resume) [65.689822] Starting subtest: suspend-resume [81.777411] Subtest suspend-resume: SUCCESS (5.438s) [81.945362] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [82.052992] Starting subtest: planes-downscale-factor-0-75-unity-scaling [82.055520] Starting dynamic subtest: pipe-A [82.117658] Dynamic subtest pipe-A: SUCCESS (0.066s) [82.132822] Starting dynamic subtest: pipe-B [83.261528] Dynamic subtest pipe-B: SUCCESS (1.139s) [83.272563] Starting dynamic subtest: pipe-C [84.377714] Dynamic subtest pipe-C: SUCCESS (1.111s) [84.388254] Starting dynamic subtest: pipe-D [85.512792] Dynamic subtest pipe-D: SUCCESS (1.130s) [85.515140] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.449s) [86.696840] [009/131] (930s left) gem_pxp (create-regular-buffer) [86.827128] Starting subtest: create-regular-buffer [86.829235] Subtest create-regular-buffer: SUCCESS (0.000s) [86.972979] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [87.033159] Starting subtest: rel-constants-invalid-rel-gen5 [87.035613] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [87.164155] [011/131] (930s left) gem_exec_nop (basic-series) [87.239397] Starting subtest: basic-series [103.537935] Subtest basic-series: SUCCESS (16.283s) [103.801548] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [103.911437] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [103.915623] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [104.046944] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip) [104.146772] Starting subtest: fbc-psr-primary-page-flip [104.149071] Starting dynamic subtest: eDP-1 [104.153337] Dynamic subtest eDP-1: SKIP (0.000s) [104.157663] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [104.241239] [014/131] (913s left) i915_pm_rps (engine-order) [104.304941] Starting subtest: engine-order [109.058666] Subtest engine-order: SUCCESS (4.751s) [109.207164] [015/131] (908s left) gem_softpin (evict-active) [109.276785] Starting subtest: evict-active [109.289788] Subtest evict-active: SUCCESS (0.015s) [109.454319] [016/131] (908s left) syncobj_timeline (wait-delayed-signal) [109.515993] Starting subtest: wait-delayed-signal [109.621389] Subtest wait-delayed-signal: SUCCESS (0.104s) [109.728324] [017/131] (907s left) kms_panel_fitting (atomic-fastset) [109.826415] Starting subtest: atomic-fastset [109.829061] Starting dynamic subtest: pipe-A-eDP-1 [109.967105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s) [109.978460] Starting dynamic subtest: pipe-B-eDP-1 [111.158329] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.190s) [111.170026] Starting dynamic subtest: pipe-C-eDP-1 [112.352338] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.191s) [112.369482] Starting dynamic subtest: pipe-D-eDP-1 [113.489368] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s) [113.491798] Subtest atomic-fastset: SUCCESS (3.663s) [114.752726] [018/131] (902s left) kms_big_fb (x-tiled-16bpp-rotate-270) [114.859830] Starting subtest: x-tiled-16bpp-rotate-270 [114.881443] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [115.040841] [019/131] (902s left) api_intel_bb (render-ccs) [115.091553] Starting subtest: render-ccs [115.440562] Subtest render-ccs: SUCCESS (0.349s) [115.583937] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [115.679159] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [115.681487] Starting dynamic subtest: pipe-A-eDP-1 [115.704237] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [115.713404] Starting dynamic subtest: pipe-B-eDP-1 [115.734781] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [115.743432] Starting dynamic subtest: pipe-C-eDP-1 [115.764418] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [115.772849] Starting dynamic subtest: pipe-D-eDP-1 [115.794569] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [115.798605] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [117.921534] [021/131] (899s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [117.976898] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [118.081286] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s) [118.180328] [022/131] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [118.284992] Starting subtest: psr-2p-primscrn-cur-indfb-move [118.289175] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [118.422281] [023/131] (899s left) gem_lmem_swapping (heavy-multi) [118.460712] Subtest heavy-multi: SKIP (0.000s) [118.503623] [024/131] (899s left) kms_async_flips (test-cursor) [118.590407] Starting subtest: test-cursor [118.594749] Subtest test-cursor: SKIP (0.000s) [119.846400] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [124.898011] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [124.900383] Starting dynamic subtest: pipe-A-eDP-1 [125.697726] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s) [125.708354] Starting dynamic subtest: pipe-B-eDP-1 [126.833761] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s) [126.838442] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.933s) [128.039300] [026/131] (889s left) kms_plane_multiple (2x-tiling-4) [128.137762] Starting subtest: 2x-tiling-4 [128.142218] Subtest 2x-tiling-4: SKIP (0.000s) [128.240286] [027/131] (889s left) gem_ctx_param (invalid-param-set) [128.301131] Starting subtest: invalid-param-set [128.303625] Subtest invalid-param-set: SUCCESS (0.000s) [128.398892] [028/131] (889s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [128.485522] Starting subtest: bad-pixel-format-y-tiled-ccs [128.487816] Starting dynamic subtest: pipe-A-eDP-1 [128.509991] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [128.520471] Starting dynamic subtest: pipe-B-eDP-1 [128.541102] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [128.549293] Starting dynamic subtest: pipe-C-eDP-1 [128.570852] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [128.581413] Starting dynamic subtest: pipe-D-eDP-1 [128.604035] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [128.608281] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [130.716056] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [130.825758] Starting subtest: plane-downscale-factor-0-5-with-modifiers [130.827983] Starting dynamic subtest: pipe-A [130.843972] Dynamic subtest pipe-A: SKIP (0.015s) [130.854462] Starting dynamic subtest: pipe-B [130.873571] Dynamic subtest pipe-B: SKIP (0.029s) [130.884722] Starting dynamic subtest: pipe-C [130.902941] Dynamic subtest pipe-C: SKIP (0.029s) [130.911433] Starting dynamic subtest: pipe-D [130.932191] Dynamic subtest pipe-D: SKIP (0.028s) [130.936163] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.103s) [131.075113] [030/131] (887s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [131.148186] Starting subtest: multi-wait-all-available-submitted-signaled [131.150603] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [131.287983] [031/131] (886s left) perf (missing-sample-flags) [131.431220] Starting subtest: missing-sample-flags [131.433486] Subtest missing-sample-flags: SUCCESS (0.000s) [131.474418] [032/131] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [131.583458] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [137.799212] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.217s) [139.004421] [033/131] (879s left) kms_pm_rpm (system-suspend-idle) [140.595812] Starting subtest: system-suspend-idle [160.280877] Subtest system-suspend-idle: SUCCESS (4.568s) [160.695550] [034/131] (857s left) kms_vblank (wait-forked) [160.795325] Starting subtest: wait-forked [160.797903] Starting dynamic subtest: pipe-A-eDP-1 [162.608134] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s) [162.624522] Starting dynamic subtest: pipe-D-eDP-1 [165.071919] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.453s) [165.074541] Subtest wait-forked: SUCCESS (4.263s) [165.967561] [035/131] (852s left) kms_big_fb (y-tiled-32bpp-rotate-0) [166.072778] Starting subtest: y-tiled-32bpp-rotate-0 [166.077933] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [166.199130] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [166.302066] Starting subtest: read-crc [166.304519] Starting dynamic subtest: pipe-A-eDP-1 [166.994230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s) [167.005970] Starting dynamic subtest: pipe-B-eDP-1 [168.335192] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.334s) [168.346109] Starting dynamic subtest: pipe-C-eDP-1 [169.732463] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s) [169.743435] Starting dynamic subtest: pipe-D-eDP-1 [171.035917] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s) [171.038885] Subtest read-crc: SUCCESS (4.728s) [171.897736] [037/131] (846s left) kms_cursor_legacy (single-move) [172.018797] Starting subtest: single-move [172.021754] Starting dynamic subtest: pipe-A [177.405683] Dynamic subtest pipe-A: SUCCESS (5.380s) [177.417027] Starting dynamic subtest: pipe-B [182.789938] Dynamic subtest pipe-B: SUCCESS (5.380s) [182.800722] Starting dynamic subtest: pipe-C [188.174660] Dynamic subtest pipe-C: SUCCESS (5.379s) [188.186127] Starting dynamic subtest: pipe-D [193.556677] Dynamic subtest pipe-D: SUCCESS (5.379s) [193.568665] Starting dynamic subtest: all-pipes [198.944465] Dynamic subtest all-pipes: SUCCESS (5.387s) [198.946925] Subtest single-move: SUCCESS (26.914s) [199.111788] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [204.175786] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [204.181480] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [205.049432] [039/131] (813s left) gem_unref_active_buffers [205.295152] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt) [205.389054] Starting subtest: fbc-psr2-primary-mmap-gtt [205.391658] Starting dynamic subtest: eDP-1 [205.396537] Dynamic subtest eDP-1: SKIP (0.000s) [205.400895] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [205.488527] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles) [205.560159] Starting subtest: invalid-signal-zero-handles [205.562811] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [205.691271] [042/131] (812s left) gen9_exec_parse (bb-oversize) [205.760575] Subtest bb-oversize: SKIP (0.000s) [205.846990] [043/131] (812s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [205.907906] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [206.016339] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s) [206.119785] [044/131] (812s left) gem_exec_reloc (basic-write-cpu-noreloc) [206.186927] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [206.271814] [045/131] (812s left) gem_mmap_offset (bad-flags) [206.331967] Starting subtest: bad-flags [206.334935] Subtest bad-flags: SUCCESS (0.000s) [206.464754] [046/131] (812s left) kms_cursor_legacy (cursor-vs-flip-legacy) [206.585246] Starting subtest: cursor-vs-flip-legacy [235.883932] Subtest cursor-vs-flip-legacy: SUCCESS (29.290s) [236.793141] [047/131] (782s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [236.889764] Starting subtest: sprite-rotation-90-pos-100-0 [236.894813] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [236.983896] [048/131] (781s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [237.084784] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [238.063493] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.978s) [238.241270] [049/131] (780s left) gem_create (busy-create) [238.309053] Starting subtest: busy-create [238.311773] Starting dynamic subtest: smem0 [271.625954] Dynamic subtest smem0: SUCCESS (33.314s) [271.628887] Subtest busy-create: SUCCESS (33.315s) [271.839609] [050/131] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [271.963706] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [276.120989] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.161s) [277.299810] [051/131] (741s left) perf (invalid-open-flags) [277.406853] Starting subtest: invalid-open-flags [277.409260] Subtest invalid-open-flags: SUCCESS (0.000s) [277.450945] [052/131] (741s left) perf (oa-formats) [277.543130] Starting subtest: oa-formats [277.545624] Starting dynamic subtest: 0-rcs0 [277.558901] Dynamic subtest 0-rcs0: SUCCESS (0.016s) [277.567952] Starting dynamic subtest: 1-vcs0 [277.582991] Dynamic subtest 1-vcs0: SUCCESS (0.024s) [277.585551] Subtest oa-formats: SUCCESS (0.041s) [277.623533] [053/131] (741s left) kms_big_fb (4-tiled-8bpp-rotate-270) [277.735646] Starting subtest: 4-tiled-8bpp-rotate-270 [277.757566] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s) [277.910967] [054/131] (741s left) kms_cursor_crc (cursor-onscreen-64x21) [278.086610] Starting subtest: cursor-onscreen-64x21 [278.132492] Subtest cursor-onscreen-64x21: SKIP (0.039s) [278.376158] [055/131] (740s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [278.465184] Starting subtest: primary-4-tiled-reflect-x-180 [285.681373] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.216s) [286.942205] [056/131] (732s left) kms_cursor_crc (cursor-onscreen-256x256) [287.172878] Starting subtest: cursor-onscreen-256x256 [287.175690] Starting dynamic subtest: pipe-A-eDP-1 [289.305368] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.129s) [289.340393] Starting dynamic subtest: pipe-D-eDP-1 [292.102901] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s) [292.105871] Subtest cursor-onscreen-256x256: SUCCESS (4.929s) [292.925781] [057/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [293.026259] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [300.256862] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.232s) [300.438548] [058/131] (718s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [300.536048] Starting subtest: async-flip-with-page-flip-events-tiled [300.908180] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [303.692633] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.785s) [303.702194] Starting dynamic subtest: pipe-A-eDP-1-4 [305.868801] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s) [305.879767] Starting dynamic subtest: pipe-A-eDP-1-4 [307.878407] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [307.891110] Starting dynamic subtest: pipe-A-eDP-1-x [310.068947] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [310.435106] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [313.216316] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s) [313.226168] Starting dynamic subtest: pipe-B-eDP-1-4 [315.403721] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s) [315.420214] Starting dynamic subtest: pipe-B-eDP-1-4 [317.414661] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [317.425297] Starting dynamic subtest: pipe-B-eDP-1-x [319.604740] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [319.968882] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [322.741395] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.779s) [322.751736] Starting dynamic subtest: pipe-C-eDP-1-4 [324.917714] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [324.934045] Starting dynamic subtest: pipe-C-eDP-1-4 [326.927294] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s) [326.938650] Starting dynamic subtest: pipe-C-eDP-1-x [329.106609] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [329.468712] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [332.262131] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.800s) [332.279636] Starting dynamic subtest: pipe-D-eDP-1-4 [334.437197] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [334.448761] Starting dynamic subtest: pipe-D-eDP-1-4 [336.447934] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [336.460550] Starting dynamic subtest: pipe-D-eDP-1-x [338.638465] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [338.641323] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.097s) [339.879257] [059/131] (679s left) perf (polling) [339.983915] Starting subtest: polling [339.986414] Starting dynamic subtest: 0-rcs0 [350.009435] Dynamic subtest 0-rcs0: SUCCESS (10.021s) [350.018644] Starting dynamic subtest: 1-vcs0 [360.031555] Dynamic subtest 1-vcs0: SUCCESS (10.018s) [360.034170] Subtest polling: SUCCESS (20.042s) [360.081256] [060/131] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [360.190629] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [360.195553] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [360.305806] [061/131] (659s left) syncobj_timeline (reset-signaled) [360.366432] Starting subtest: reset-signaled [360.369040] Subtest reset-signaled: SUCCESS (0.000s) [360.508313] [062/131] (659s left) kms_rmfb (rmfb-ioctl) [360.602686] Starting subtest: rmfb-ioctl [360.605579] Starting dynamic subtest: pipe-A-eDP-1 [360.706035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [360.716602] Starting dynamic subtest: pipe-B-eDP-1 [361.927411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s) [361.936643] Starting dynamic subtest: pipe-C-eDP-1 [363.058334] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s) [363.071527] Starting dynamic subtest: pipe-D-eDP-1 [364.293143] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s) [364.295792] Subtest rmfb-ioctl: SUCCESS (3.693s) [365.530562] [063/131] (654s left) gem_userptr_blits (create-destroy-sync) [365.610421] Starting subtest: create-destroy-sync [370.616099] Subtest create-destroy-sync: SUCCESS (5.006s) [370.777972] [064/131] (648s left) gem_exec_reloc (basic-gtt-cpu-active) [370.852386] Subtest basic-gtt-cpu-active: SKIP (0.000s) [370.916829] [065/131] (648s left) api_intel_allocator (execbuf-with-allocator) [370.970556] Starting subtest: execbuf-with-allocator [370.978256] Subtest execbuf-with-allocator: SUCCESS (0.010s) [371.097402] [066/131] (648s left) kms_lease (cursor-implicit-plane) [371.198195] Starting subtest: cursor-implicit-plane [371.200537] Starting dynamic subtest: pipe-A-eDP-1 [371.649447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s) [371.659992] Starting dynamic subtest: pipe-B-eDP-1 [372.740733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.093s) [372.754503] Starting dynamic subtest: pipe-C-eDP-1 [373.844850] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s) [373.859937] Starting dynamic subtest: pipe-D-eDP-1 [374.974782] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s) [374.977433] Subtest cursor-implicit-plane: SUCCESS (3.778s) [375.862409] [067/131] (643s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [375.989679] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [375.994495] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [376.158699] [068/131] (643s left) syncobj_wait (invalid-signal-illegal-handle) [376.221720] Starting subtest: invalid-signal-illegal-handle [376.223900] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [376.331697] [069/131] (643s left) kms_psr (psr-primary-blt) [376.431630] Starting subtest: psr-primary-blt [376.433827] Starting dynamic subtest: eDP-1 [378.155685] Dynamic subtest eDP-1: SUCCESS (1.722s) [378.158326] Subtest psr-primary-blt: SUCCESS (1.723s) [379.043128] [070/131] (640s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [379.144459] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [379.146827] Starting dynamic subtest: pipe-A-eDP-1 [379.209643] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [379.219102] Starting dynamic subtest: pipe-B-eDP-1 [379.279891] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [379.290910] Starting dynamic subtest: pipe-C-eDP-1 [379.358827] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [379.373649] Starting dynamic subtest: pipe-D-eDP-1 [379.442483] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [379.447752] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [381.407723] [071/131] (638s left) kms_psr (pr-primary-blt) [381.510952] Starting subtest: pr-primary-blt [381.516865] Subtest pr-primary-blt: SKIP (0.000s) [381.609532] [072/131] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [381.718536] Starting subtest: psr-2p-primscrn-spr-indfb-move [381.723521] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [381.856165] [073/131] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [381.953563] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [381.956042] Starting dynamic subtest: pipe-A-default-mode [383.144846] Dynamic subtest pipe-A-default-mode: SKIP (1.188s) [383.150121] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.192s) [383.328243] [074/131] (636s left) gem_exec_schedule (u-semaphore-noskip) [383.411764] Starting subtest: u-semaphore-noskip [383.814906] Subtest u-semaphore-noskip: SUCCESS (0.408s) [384.203987] [075/131] (635s left) i915_drm_fdinfo (memory-info-idle) [384.250734] Starting subtest: memory-info-idle [384.253225] Starting dynamic subtest: smem0 [384.326705] Dynamic subtest smem0: SUCCESS (0.075s) [384.329374] Subtest memory-info-idle: SUCCESS (0.076s) [384.422164] [076/131] (635s left) i915_selftest (live) [386.428060] Starting subtest: live [386.430481] Starting dynamic subtest: sanitycheck [390.565442] Dynamic subtest sanitycheck: SUCCESS (4.138s) [390.575652] Starting dynamic subtest: uncore [396.346160] Dynamic subtest uncore: SUCCESS (5.780s) [396.355700] Starting dynamic subtest: workarounds [401.009157] Dynamic subtest workarounds: SUCCESS (4.662s) [401.019204] Starting dynamic subtest: gt_engines [406.997556] Dynamic subtest gt_engines: SUCCESS (5.987s) [407.007417] Starting dynamic subtest: gt_timelines [426.028910] Dynamic subtest gt_timelines: SUCCESS (19.031s) [426.039349] Starting dynamic subtest: gt_contexts [430.317828] Dynamic subtest gt_contexts: SUCCESS (4.287s) [430.328212] Starting dynamic subtest: gt_lrc [436.043952] Dynamic subtest gt_lrc: SUCCESS (5.723s) [436.060203] Starting dynamic subtest: gt_mocs [440.533717] Dynamic subtest gt_mocs: SUCCESS (4.487s) [440.543303] Starting dynamic subtest: gt_pm [446.775858] Dynamic subtest gt_pm: SUCCESS (6.240s) [446.785767] Starting dynamic subtest: gt_heartbeat [450.879529] Dynamic subtest gt_heartbeat: SUCCESS (4.101s) [450.889482] Starting dynamic subtest: gt_tlb [461.718655] Dynamic subtest gt_tlb: SUCCESS (10.836s) [461.728520] Starting dynamic subtest: requests [474.602596] Dynamic subtest requests: SUCCESS (12.857s) [474.612328] Starting dynamic subtest: migrate [481.828919] Dynamic subtest migrate: SUCCESS (7.249s) [481.837879] Starting dynamic subtest: active [485.890385] Dynamic subtest active: SUCCESS (4.058s) [485.900259] Starting dynamic subtest: objects [490.427676] Dynamic subtest objects: SUCCESS (4.535s) [490.437818] Starting dynamic subtest: mman [495.088102] Dynamic subtest mman: SUCCESS (4.659s) [495.097903] Starting dynamic subtest: dmabuf [499.355510] Dynamic subtest dmabuf: SUCCESS (4.264s) [499.365700] Starting dynamic subtest: vma [503.448119] Dynamic subtest vma: SUCCESS (4.090s) [503.464033] Starting dynamic subtest: coherency [508.886185] Dynamic subtest coherency: SUCCESS (5.435s) [508.896477] Starting dynamic subtest: gtt [522.217277] Dynamic subtest gtt: SUCCESS (13.326s) [522.232703] Starting dynamic subtest: gem [529.468039] Dynamic subtest gem: SUCCESS (7.248s) [529.478220] Starting dynamic subtest: evict [536.284476] Dynamic subtest evict: SUCCESS (6.813s) [536.295555] Starting dynamic subtest: hugepages [546.703131] Dynamic subtest hugepages: SUCCESS (10.415s) [546.712699] Starting dynamic subtest: gem_contexts [574.967228] Dynamic subtest gem_contexts: SUCCESS (28.257s) [574.977065] Starting dynamic subtest: client [579.179332] Dynamic subtest client: SUCCESS (4.210s) [579.195493] Starting dynamic subtest: gem_migrate [583.278258] Dynamic subtest gem_migrate: SUCCESS (4.095s) [583.289119] Starting dynamic subtest: reset [587.563181] Dynamic subtest reset: SUCCESS (4.282s) [587.579431] Starting dynamic subtest: memory_region [591.726629] Dynamic subtest memory_region: SUCCESS (4.160s) [591.737777] Starting dynamic subtest: hangcheck [606.126980] Dynamic subtest hangcheck: SUCCESS (14.396s) [606.137870] Starting dynamic subtest: execlists [610.226533] Dynamic subtest execlists: SUCCESS (4.095s) [610.236761] Starting dynamic subtest: ring_submission [614.334417] Dynamic subtest ring_submission: SUCCESS (4.105s) [614.344276] Starting dynamic subtest: perf [620.120639] Dynamic subtest perf: SUCCESS (5.783s) [620.130369] Starting dynamic subtest: slpc [635.588892] Dynamic subtest slpc: SUCCESS (15.462s) [635.604499] Starting dynamic subtest: guc [641.047316] Dynamic subtest guc: SUCCESS (5.455s) [641.057779] Starting dynamic subtest: guc_multi_lrc [645.060096] Dynamic subtest guc_multi_lrc: SUCCESS (4.012s) [645.069719] Starting dynamic subtest: guc_hang [649.864231] Dynamic subtest guc_hang: SUCCESS (4.803s) [649.874516] Starting dynamic subtest: late_gt_pm [654.095929] Dynamic subtest late_gt_pm: SUCCESS (4.230s) [654.098897] Subtest live: SUCCESS (267.643s) [654.130226] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [654.131058] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [654.134921] [077/131] (365s left) gem_userptr_blits (nohangcheck) [656.986442] Starting subtest: nohangcheck [657.263890] Subtest nohangcheck: SUCCESS (0.274s) [657.362425] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [657.363635] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [657.367543] [078/131] (362s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [657.463560] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [657.465874] Starting dynamic subtest: pipe-A-eDP-1 [658.297428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.827s) [658.307683] Starting dynamic subtest: pipe-B-eDP-1 [659.882877] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.583s) [659.891535] Starting dynamic subtest: pipe-C-eDP-1 [661.428348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s) [661.439155] Starting dynamic subtest: pipe-D-eDP-1 [662.957573] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s) [662.959660] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.488s) [664.133214] [079/131] (356s left) gem_softpin (allocator-nopin) [664.197511] Starting subtest: allocator-nopin [664.293136] Subtest allocator-nopin: SUCCESS (0.095s) [664.461878] [080/131] (355s left) kms_draw_crc (draw-method-pwrite) [664.562516] Starting subtest: draw-method-pwrite [664.564890] Starting dynamic subtest: xrgb8888-untiled [665.106446] Dynamic subtest xrgb8888-untiled: SUCCESS (0.544s) [665.124623] Starting dynamic subtest: rgb565-untiled [665.551378] Dynamic subtest rgb565-untiled: SUCCESS (0.444s) [665.568752] Starting dynamic subtest: xrgb2101010-untiled [666.071698] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.521s) [666.089948] Starting dynamic subtest: xbgr16161616f-untiled [666.793675] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.721s) [666.811002] Starting dynamic subtest: xrgb8888-xtiled [668.527168] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.733s) [668.545327] Starting dynamic subtest: rgb565-xtiled [669.594639] Dynamic subtest rgb565-xtiled: SUCCESS (1.065s) [669.611825] Starting dynamic subtest: xrgb2101010-xtiled [671.448877] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.855s) [671.458567] Starting dynamic subtest: xbgr16161616f-xtiled [674.637700] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.188s) [674.647760] Starting dynamic subtest: xrgb8888-4tiled [675.714872] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.077s) [675.723809] Starting dynamic subtest: rgb565-4tiled [676.259623] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s) [676.269314] Starting dynamic subtest: xrgb2101010-4tiled [677.325591] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.066s) [677.334777] Starting dynamic subtest: xbgr16161616f-4tiled [680.225498] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.899s) [680.227915] Subtest draw-method-pwrite: SUCCESS (15.667s) [680.365269] [081/131] (339s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [680.481755] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [680.486792] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [680.626442] [082/131] (339s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [680.736892] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [680.741881] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [680.860304] [083/131] (339s left) syncobj_timeline (host-signal-points) [680.924051] Starting subtest: host-signal-points [680.926803] Subtest host-signal-points: SUCCESS (0.004s) [681.061504] [084/131] (339s left) gem_mmap_gtt (basic-small-bo) [681.137682] Subtest basic-small-bo: SKIP (0.000s) [681.213466] [085/131] (339s left) perf_pmu (semaphore-wait-idle) [681.261925] Starting subtest: semaphore-wait-idle [681.264541] Starting dynamic subtest: rcs0 [681.776092] Dynamic subtest rcs0: SUCCESS (0.514s) [681.788047] Starting dynamic subtest: bcs0 [682.289485] Dynamic subtest bcs0: SUCCESS (0.510s) [682.302079] Starting dynamic subtest: vcs0 [682.803185] Dynamic subtest vcs0: SUCCESS (0.510s) [682.816042] Starting dynamic subtest: vcs1 [683.315433] Dynamic subtest vcs1: SUCCESS (0.511s) [683.328064] Starting dynamic subtest: vecs0 [683.832510] Dynamic subtest vecs0: SUCCESS (0.513s) [683.848248] Starting dynamic subtest: ccs0 [684.349766] Dynamic subtest ccs0: SUCCESS (0.512s) [684.352882] Subtest semaphore-wait-idle: SUCCESS (3.089s) [685.726292] [086/131] (334s left) kms_addfb_basic (no-handle) [685.794408] Starting subtest: no-handle [685.796884] Subtest no-handle: SUCCESS (0.000s) [685.973906] [087/131] (334s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [686.075793] Starting subtest: fbcpsr-rgb101010-draw-pwrite [693.106435] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.036s) [693.232565] [088/131] (327s left) gem_render_copy (yf-tiled-ccs-to-linear) [693.303541] Starting subtest: yf-tiled-ccs-to-linear [693.308966] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [693.517619] [089/131] (327s left) kms_flip (wf_vblank-ts-check) [693.613544] Starting subtest: wf_vblank-ts-check [693.616560] Starting dynamic subtest: A-eDP1 [702.569425] Dynamic subtest A-eDP1: SUCCESS (8.956s) [702.579297] Starting dynamic subtest: B-eDP1 [711.493722] Dynamic subtest B-eDP1: SUCCESS (8.924s) [711.504620] Starting dynamic subtest: C-eDP1 [720.410448] Dynamic subtest C-eDP1: SUCCESS (8.915s) [720.421298] Starting dynamic subtest: D-eDP1 [729.342348] Dynamic subtest D-eDP1: SUCCESS (8.930s) [729.348054] Subtest wf_vblank-ts-check: SUCCESS (35.736s) [730.598908] [090/131] (290s left) gem_exec_schedule (deep) [730.785729] Starting subtest: deep [730.788510] Starting dynamic subtest: rcs0 [735.482591] Dynamic subtest rcs0: SKIP (4.694s) [735.494784] Starting dynamic subtest: vcs0 [745.938681] Dynamic subtest vcs0: SUCCESS (10.456s) [745.949738] Starting dynamic subtest: vcs1 [757.030196] Dynamic subtest vcs1: SUCCESS (11.090s) [757.041538] Starting dynamic subtest: vecs0 [768.383468] Dynamic subtest vecs0: SUCCESS (11.352s) [768.393904] Starting dynamic subtest: ccs0 [780.526993] Dynamic subtest ccs0: SUCCESS (12.142s) [780.530691] Subtest deep: SUCCESS (49.739s) [781.583699] [091/131] (239s left) kms_sequence (queue-idle) [781.674089] Starting subtest: queue-idle [781.676727] Starting dynamic subtest: pipe-A-eDP-1 [783.498499] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s) [783.508685] Starting dynamic subtest: pipe-B-eDP-1 [785.953550] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s) [785.963349] Starting dynamic subtest: pipe-C-eDP-1 [788.441164] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.485s) [788.451762] Starting dynamic subtest: pipe-D-eDP-1 [790.861911] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.418s) [790.864508] Subtest queue-idle: SUCCESS (9.187s) [791.730055] [092/131] (229s left) gem_gtt_cpu_tlb [791.861332] [093/131] (228s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [791.960377] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [798.522806] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.562s) [798.670046] [094/131] (222s left) gem_eio (create-ext) [798.902070] Starting subtest: create-ext [799.225606] Subtest create-ext: SUCCESS (0.322s) [799.401151] [095/131] (221s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [799.467498] Subtest writes-after-reads-uncached: SKIP (0.000s) [799.536998] [096/131] (221s left) sysfs_preempt_timeout (idempotent) [799.603153] Starting subtest: idempotent [799.605277] Starting dynamic subtest: vecs0 [799.607577] Dynamic subtest vecs0: SUCCESS (0.000s) [799.618368] Starting dynamic subtest: ccs0 [799.620624] Dynamic subtest ccs0: SUCCESS (0.000s) [799.629891] Starting dynamic subtest: vcs0 [799.632146] Dynamic subtest vcs0: SUCCESS (0.000s) [799.641453] Starting dynamic subtest: bcs0 [799.643569] Dynamic subtest bcs0: SUCCESS (0.000s) [799.655133] Starting dynamic subtest: rcs0 [799.657532] Dynamic subtest rcs0: SUCCESS (0.000s) [799.666160] Starting dynamic subtest: vcs1 [799.668546] Dynamic subtest vcs1: SUCCESS (0.000s) [799.670780] Subtest idempotent: SUCCESS (0.006s) [799.736208] [097/131] (221s left) gem_busy (semaphore) [799.925665] Subtest semaphore: SKIP (0.000s) [800.166191] [098/131] (220s left) sriov_basic (enable-vfs-bind-unbind-each) [800.227258] Starting subtest: enable-vfs-bind-unbind-each [800.229877] Starting dynamic subtest: numvfs-1 [800.316698] Dynamic subtest numvfs-1: FAIL (0.031s) [800.327868] Starting dynamic subtest: numvfs-2 [800.413892] Dynamic subtest numvfs-2: FAIL (0.004s) [800.424905] Starting dynamic subtest: numvfs-3 [800.512923] Dynamic subtest numvfs-3: FAIL (0.004s) [800.523803] Starting dynamic subtest: numvfs-4 [800.611215] Dynamic subtest numvfs-4: FAIL (0.003s) [800.622327] Starting dynamic subtest: numvfs-5 [800.711364] Dynamic subtest numvfs-5: FAIL (0.004s) [800.722394] Starting dynamic subtest: numvfs-6 [800.810659] Dynamic subtest numvfs-6: FAIL (0.003s) [800.820876] Starting dynamic subtest: numvfs-7 [800.909376] Dynamic subtest numvfs-7: FAIL (0.004s) [800.921140] Starting dynamic subtest: numvfs-random [801.013449] Dynamic subtest numvfs-random: FAIL (0.003s) [801.015771] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s) [801.058713] [099/131] (220s left) kms_pm_lpsp (screens-disabled) [802.172698] Starting subtest: screens-disabled [802.177744] Subtest screens-disabled: SKIP (0.000s) [802.269207] [100/131] (218s left) gem_exec_capture (capture-invisible) [802.335741] Starting subtest: capture-invisible [802.338192] Starting dynamic subtest: smem0 [802.342908] Dynamic subtest smem0: SKIP (0.000s) [802.347681] Subtest capture-invisible: SKIP (0.001s) [802.470735] [101/131] (218s left) gem_lmem_swapping (verify-ccs) [802.521673] Subtest verify-ccs: SKIP (0.000s) [802.568288] [102/131] (218s left) kms_joiner (basic-force-ultra-joiner) [802.672057] Starting subtest: basic-force-ultra-joiner [802.677439] Subtest basic-force-ultra-joiner: SKIP (0.000s) [802.763203] [103/131] (218s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [802.878155] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [809.442495] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.567s) [809.583522] [104/131] (211s left) kms_color (legacy-gamma) [809.679658] Starting subtest: legacy-gamma [809.682636] Starting dynamic subtest: pipe-A-eDP-1 [810.420945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s) [810.432025] Starting dynamic subtest: pipe-B-eDP-1 [811.812515] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s) [811.823270] Starting dynamic subtest: pipe-C-eDP-1 [813.195426] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s) [813.205921] Starting dynamic subtest: pipe-D-eDP-1 [814.515723] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [814.518232] Subtest legacy-gamma: SUCCESS (4.837s) [815.353371] [105/131] (205s left) gem_exec_schedule (wide) [815.535569] Starting subtest: wide [815.538202] Starting dynamic subtest: rcs0 [826.803459] Dynamic subtest rcs0: SUCCESS (11.266s) [826.815809] Starting dynamic subtest: vcs0 [837.857997] Dynamic subtest vcs0: SUCCESS (11.052s) [837.869474] Starting dynamic subtest: vcs1 [847.899768] Dynamic subtest vcs1: SUCCESS (10.039s) [847.912280] Starting dynamic subtest: vecs0 [859.763647] Dynamic subtest vecs0: SUCCESS (11.862s) [859.774568] Starting dynamic subtest: ccs0 [872.535982] Dynamic subtest ccs0: SUCCESS (12.769s) [872.538702] Subtest wide: SUCCESS (56.993s) [873.803897] [106/131] (147s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [873.899711] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [873.902360] Starting dynamic subtest: pipe-A-default-mode [874.194730] Dynamic subtest pipe-A-default-mode: SKIP (0.290s) [874.200351] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.291s) [875.074003] [107/131] (146s left) kms_big_fb (linear-64bpp-rotate-180) [875.185765] Starting subtest: linear-64bpp-rotate-180 [876.898199] Subtest linear-64bpp-rotate-180: SUCCESS (1.714s) [877.084104] [108/131] (144s left) gem_ppgtt (blt-vs-render-ctxn) [877.150906] Starting subtest: blt-vs-render-ctxN [910.311054] Subtest blt-vs-render-ctxN: SUCCESS (33.154s) [910.479195] [109/131] (111s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [910.633424] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [910.638428] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [910.739235] [110/131] (110s left) kms_chamelium_frames (dp-frame-dump) [911.139531] Subtest dp-frame-dump: SKIP (0.000s) [911.973136] [111/131] (109s left) kms_psr2_su (page_flip-nv12) [912.042725] Subtest page_flip-NV12: SKIP (0.000s) [912.103870] [112/131] (109s left) gem_tiling_max_stride [912.220090] [113/131] (109s left) perf_pmu (busy-idle) [912.264771] Starting subtest: busy-idle [912.267523] Starting dynamic subtest: rcs0 [912.960191] Dynamic subtest rcs0: SUCCESS (0.695s) [912.973886] Starting dynamic subtest: bcs0 [913.632442] Dynamic subtest bcs0: SUCCESS (0.670s) [913.646068] Starting dynamic subtest: vcs0 [915.637037] Dynamic subtest vcs0: SUCCESS (2.001s) [915.650887] Starting dynamic subtest: vcs1 [917.685392] Dynamic subtest vcs1: SUCCESS (2.045s) [917.699703] Starting dynamic subtest: vecs0 [919.668354] Dynamic subtest vecs0: SUCCESS (1.979s) [919.681604] Starting dynamic subtest: ccs0 [920.350821] Dynamic subtest ccs0: SUCCESS (0.681s) [920.353823] Subtest busy-idle: SUCCESS (8.087s) [920.479667] [114/131] (101s left) dmabuf_sync_file (export-before-signal) [920.530692] Starting subtest: export-before-signal [920.533461] Subtest export-before-signal: SUCCESS (0.001s) [920.612658] [115/131] (101s left) gem_exec_reloc (basic-cpu-read) [920.668670] Subtest basic-cpu-read: SKIP (0.000s) [920.749949] [116/131] (101s left) kms_hdr (bpc-switch) [920.848410] Starting subtest: bpc-switch [921.976937] Starting dynamic subtest: pipe-A-eDP-1 [925.372726] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.396s) [925.375876] Subtest bpc-switch: SUCCESS (4.526s) [925.522595] [117/131] ( 96s left) perf (i915-ref-count) [925.644422] Starting subtest: i915-ref-count [925.705901] Subtest i915-ref-count: SUCCESS (0.060s) [925.762556] [118/131] ( 96s left) gem_ctx_isolation (nonpriv) [925.834771] Starting subtest: nonpriv [925.837946] Starting dynamic subtest: rcs0 [926.080775] Dynamic subtest rcs0: SUCCESS (0.245s) [926.093564] Starting dynamic subtest: bcs0 [926.335797] Dynamic subtest bcs0: SUCCESS (0.254s) [926.348903] Starting dynamic subtest: vcs0 [926.615361] Dynamic subtest vcs0: SUCCESS (0.279s) [926.628197] Starting dynamic subtest: vcs1 [927.915096] Dynamic subtest vcs1: SUCCESS (1.299s) [927.927803] Starting dynamic subtest: vecs0 [929.929558] Dynamic subtest vecs0: SUCCESS (2.013s) [929.940029] Starting dynamic subtest: ccs0 [931.939501] Dynamic subtest ccs0: SUCCESS (2.009s) [931.942048] Subtest nonpriv: SUCCESS (6.105s) [932.220569] [119/131] ( 89s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [932.277722] Starting subtest: y-tiled-to-vebox-x-tiled [932.282907] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [932.490667] [120/131] ( 89s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [932.587394] Starting subtest: plane-use-after-nonblocking-unbind [932.589692] Starting dynamic subtest: pipe-A-eDP-1 [932.648783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [932.973110] Starting dynamic subtest: pipe-B-eDP-1 [933.743180] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.780s) [934.041519] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.455s) [934.928007] [121/131] ( 87s left) i915_hangman (engine-error-state-capture) [935.007434] Starting subtest: engine-error-state-capture [935.009883] Starting dynamic subtest: rcs0 [938.580562] Dynamic subtest rcs0: SUCCESS (3.572s) [938.594620] Starting dynamic subtest: bcs0 [944.659687] Dynamic subtest bcs0: SUCCESS (6.076s) [944.673610] Starting dynamic subtest: vcs0 [950.610612] Dynamic subtest vcs0: SUCCESS (5.946s) [950.624894] Starting dynamic subtest: vcs1 [956.562359] Dynamic subtest vcs1: SUCCESS (5.949s) [956.576897] Starting dynamic subtest: vecs0 [963.603343] Dynamic subtest vecs0: SUCCESS (7.036s) [963.617817] Starting dynamic subtest: ccs0 [969.621420] Dynamic subtest ccs0: SUCCESS (6.012s) [969.626813] Subtest engine-error-state-capture: SUCCESS (34.608s) [969.726067] [122/131] ( 52s left) gem_exec_schedule (pi-shared-iova) [969.922571] Starting subtest: pi-shared-iova [969.924864] Starting dynamic subtest: rcs0 [970.064367] Dynamic subtest rcs0: SUCCESS (0.145s) [970.076784] Starting dynamic subtest: vcs0 [970.153754] Dynamic subtest vcs0: SUCCESS (0.089s) [970.164777] Starting dynamic subtest: vcs1 [970.239635] Dynamic subtest vcs1: SUCCESS (0.086s) [970.252747] Starting dynamic subtest: vecs0 [970.329825] Dynamic subtest vecs0: SUCCESS (0.088s) [970.342748] Starting dynamic subtest: ccs0 [970.451540] Dynamic subtest ccs0: SUCCESS (0.120s) [970.454124] Subtest pi-shared-iova: SUCCESS (0.532s) [971.821497] [123/131] ( 50s left) syncobj_wait (invalid-reset-illegal-handle) [971.878214] Starting subtest: invalid-reset-illegal-handle [971.880742] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [972.008241] [124/131] ( 50s left) syncobj_wait (single-wait-all-for-submit-signaled) [972.071147] Starting subtest: single-wait-all-for-submit-signaled [972.073952] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [972.192248] [125/131] ( 50s left) kms_cursor_crc (cursor-sliding-512x170) [972.486992] Starting subtest: cursor-sliding-512x170 [972.492990] Subtest cursor-sliding-512x170: SKIP (0.001s) [972.681181] [126/131] ( 49s left) kms_chamelium_hpd (hdmi-hpd-fast) [973.051792] Subtest hdmi-hpd-fast: SKIP (0.000s) [973.906967] [127/131] ( 48s left) gem_ctx_persistence (hostile) [973.964732] Starting subtest: hostile [984.119804] Subtest hostile: SUCCESS (10.148s) [984.267168] [128/131] ( 38s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [984.373594] Starting subtest: fbc-rgb565-draw-blt [988.536422] Subtest fbc-rgb565-draw-blt: SUCCESS (4.167s) [989.753257] [129/131] ( 32s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [989.869817] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [999.109447] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.241s) [999.310205] [130/131] ( 23s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [999.413765] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [999.419039] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [999.549158] [131/131] ( 22s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [999.652148] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [999.657313] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [999.784069] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.