[39.638363] Initializing watchdogs [39.638536] /dev/watchdog0 [39.648273] [001/171] (960s left) i915_module_load (load) [39.784482] Starting subtest: load [42.254198] Subtest load: SUCCESS (2.471s) [42.276986] [002/171] (957s left) core_auth (basic-auth) [42.395781] Starting subtest: basic-auth [42.397266] Subtest basic-auth: SUCCESS (0.001s) [42.466893] [003/171] (957s left) debugfs_test (read_all_entries) [42.609364] Starting subtest: read_all_entries [42.688944] Subtest read_all_entries: SUCCESS (0.079s) [42.799075] [004/171] (957s left) debugfs_test (basic-hwmon) [42.918936] Starting subtest: basic-hwmon [42.921433] Subtest basic-hwmon: SKIP (0.000s) [43.019845] [005/171] (957s left) fbdev (eof) [43.154376] Starting subtest: eof [43.155526] Subtest eof: SUCCESS (0.000s) [43.243215] [006/171] (957s left) fbdev (info) [43.373971] Starting subtest: info [43.375361] Subtest info: SUCCESS (0.000s) [43.471838] [007/171] (956s left) fbdev (nullptr) [43.604591] Starting subtest: nullptr [43.606122] Subtest nullptr: SUCCESS (0.000s) [43.672823] [008/171] (956s left) fbdev (read) [43.805619] Starting subtest: read [50.880746] Subtest read: SUCCESS (7.067s) [50.933046] [009/171] (949s left) fbdev (write) [51.055674] Starting subtest: write [54.822322] Subtest write: SUCCESS (3.733s) [54.866977] [010/171] (945s left) gem_basic (bad-close) [54.978937] Starting subtest: bad-close [54.981420] Subtest bad-close: SUCCESS (0.000s) [55.050224] [011/171] (945s left) gem_basic (create-close) [55.161987] Starting subtest: create-close [55.164204] Subtest create-close: SUCCESS (0.000s) [55.249620] [012/171] (945s left) gem_basic (create-fd-close) [55.360897] Starting subtest: create-fd-close [55.363476] Subtest create-fd-close: SUCCESS (0.000s) [55.451042] [013/171] (944s left) gem_busy (busy@all-engines) [55.581249] Starting subtest: busy [55.582480] Starting dynamic subtest: all-engines [55.623583] Dynamic subtest all-engines: SUCCESS (0.045s) [55.624845] Subtest busy: SUCCESS (0.046s) [56.001018] [014/171] (944s left) gem_close_race (basic-process) [56.132189] Starting subtest: basic-process [56.191857] Subtest basic-process: SUCCESS (0.059s) [56.384692] [015/171] (944s left) gem_close_race (basic-threads) [56.512053] Starting subtest: basic-threads [57.686289] Subtest basic-threads: SUCCESS (1.174s) [57.902357] [016/171] (942s left) gem_ctx_create (basic) [58.030071] Starting subtest: basic [58.031389] Subtest basic: SUCCESS (0.000s) [58.234771] [017/171] (942s left) gem_ctx_create (basic-files) [58.356581] Starting subtest: basic-files [60.377186] Subtest basic-files: SUCCESS (2.021s) [60.586376] [018/171] (939s left) gem_ctx_exec (basic) [60.720480] Starting subtest: basic [60.726093] Subtest basic: SUCCESS (0.005s) [60.835310] [019/171] (939s left) gem_exec_basic (basic) [60.954340] Starting subtest: basic [60.955453] Starting dynamic subtest: rcs0-smem [60.956478] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [60.967944] Starting dynamic subtest: bcs0-smem [60.969317] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [60.979225] Starting dynamic subtest: vcs0-smem [60.980492] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [60.990373] Starting dynamic subtest: vecs0-smem [60.991498] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [60.992676] Subtest basic: SUCCESS (0.005s) [61.151881] [020/171] (939s left) gem_exec_create (basic) [61.275791] Starting subtest: basic [61.276950] Starting dynamic subtest: smem [63.340214] Dynamic subtest smem: SUCCESS (2.045s) [63.341657] Subtest basic: SUCCESS (2.045s) [63.528657] [021/171] (937s left) gem_exec_fence (basic-busy) [63.807850] Starting subtest: basic-busy [63.819996] Starting dynamic subtest: rcs0 [63.844109] Dynamic subtest rcs0: SUCCESS (0.027s) [63.855635] Starting dynamic subtest: bcs0 [63.857905] Dynamic subtest bcs0: SUCCESS (0.023s) [63.868169] Starting dynamic subtest: vcs0 [63.870282] Dynamic subtest vcs0: SUCCESS (0.023s) [63.881108] Starting dynamic subtest: vecs0 [63.884901] Dynamic subtest vecs0: SUCCESS (0.018s) [63.886179] Subtest basic-busy: SUCCESS (0.092s) [64.499358] [022/171] (936s left) gem_exec_fence (basic-wait) [64.778637] Starting subtest: basic-wait [64.780357] Starting dynamic subtest: rcs0 [64.806621] Dynamic subtest rcs0: SUCCESS (0.033s) [64.819096] Starting dynamic subtest: bcs0 [64.839167] Dynamic subtest bcs0: SUCCESS (0.033s) [64.851333] Starting dynamic subtest: vcs0 [64.866386] Dynamic subtest vcs0: SUCCESS (0.028s) [64.877398] Starting dynamic subtest: vecs0 [64.899082] Dynamic subtest vecs0: SUCCESS (0.032s) [64.900607] Subtest basic-wait: SUCCESS (0.126s) [65.435621] [023/171] (935s left) gem_exec_fence (basic-await) [65.723857] Starting subtest: basic-await [65.725106] Starting dynamic subtest: rcs0 [65.808063] Dynamic subtest rcs0: SUCCESS (0.088s) [65.830277] Starting dynamic subtest: bcs0 [65.907223] Dynamic subtest bcs0: SUCCESS (0.099s) [65.933744] Starting dynamic subtest: vcs0 [66.027371] Dynamic subtest vcs0: SUCCESS (0.120s) [66.052740] Starting dynamic subtest: vecs0 [66.145730] Dynamic subtest vecs0: SUCCESS (0.118s) [66.147651] Subtest basic-await: SUCCESS (0.427s) [66.717297] [024/171] (933s left) gem_exec_fence (nb-await) [66.995585] Starting subtest: nb-await [66.996883] Starting dynamic subtest: rcs0 [67.055725] Dynamic subtest rcs0: SUCCESS (0.068s) [67.075299] Starting dynamic subtest: bcs0 [67.126755] Dynamic subtest bcs0: SUCCESS (0.070s) [67.153348] Starting dynamic subtest: vcs0 [67.199250] Dynamic subtest vcs0: SUCCESS (0.073s) [67.225636] Starting dynamic subtest: vecs0 [67.270825] Dynamic subtest vecs0: SUCCESS (0.071s) [67.274105] Subtest nb-await: SUCCESS (0.283s) [67.802056] [025/171] (932s left) gem_exec_gttfill (basic) [67.926410] Starting subtest: basic [75.334200] Subtest basic: SUCCESS (7.399s) [75.522614] [026/171] (925s left) gem_exec_parallel (engines) [75.716715] Starting subtest: engines [75.717926] Starting dynamic subtest: basic [78.052429] Dynamic subtest basic: SUCCESS (2.314s) [78.064869] Starting dynamic subtest: contexts [81.370786] Dynamic subtest contexts: SUCCESS (3.332s) [81.384550] Starting dynamic subtest: fds [84.861766] Dynamic subtest fds: SUCCESS (3.500s) [84.875286] Starting dynamic subtest: userptr [87.227099] Dynamic subtest userptr: SUCCESS (2.336s) [87.229042] Subtest engines: SUCCESS (11.482s) [87.424798] [027/171] (913s left) gem_exec_store (basic) [87.578519] Starting subtest: basic [87.639120] Subtest basic: SUCCESS (0.060s) [87.837247] [028/171] (912s left) gem_flink_basic (bad-flink) [87.949415] Starting subtest: bad-flink [87.950493] Subtest bad-flink: SUCCESS (0.000s) [88.036214] [029/171] (912s left) gem_flink_basic (bad-open) [88.149854] Starting subtest: bad-open [88.151045] Subtest bad-open: SUCCESS (0.000s) [88.236442] [030/171] (912s left) gem_flink_basic (basic) [88.347656] Starting subtest: basic [88.348728] Subtest basic: SUCCESS (0.000s) [88.453090] [031/171] (912s left) gem_flink_basic (double-flink) [88.563669] Starting subtest: double-flink [88.564807] Subtest double-flink: SUCCESS (0.000s) [88.653672] [032/171] (912s left) gem_flink_basic (flink-lifetime) [88.765712] Starting subtest: flink-lifetime [88.767018] Subtest flink-lifetime: SUCCESS (0.002s) [88.886257] [033/171] (911s left) gem_huc_copy (huc-copy) [89.004962] Starting subtest: huc-copy [89.007308] Subtest huc-copy: SKIP (0.000s) [89.119856] [034/171] (911s left) gem_linear_blits (basic) [89.379922] Starting subtest: basic [89.393534] Subtest basic: SUCCESS (0.014s) [89.523192] [035/171] (911s left) gem_mmap (basic) [89.701104] Starting subtest: basic [89.705919] Subtest basic: SUCCESS (0.001s) [89.802833] [036/171] (911s left) gem_mmap_gtt (basic) [89.914608] Starting subtest: basic [89.915757] Subtest basic: SUCCESS (0.001s) [90.004101] [037/171] (910s left) gem_render_linear_blits (basic) [90.122319] Starting subtest: basic [90.174425] Subtest basic: SUCCESS (0.049s) [90.244156] [038/171] (910s left) gem_render_tiled_blits (basic) [90.363862] Starting subtest: basic [90.422301] Subtest basic: SUCCESS (0.058s) [90.494095] [039/171] (910s left) gem_ringfill (basic-all) [90.761338] Starting subtest: basic-all [92.000609] Subtest basic-all: SUCCESS (1.232s) [92.071759] [040/171] (908s left) gem_softpin (allocator-basic) [92.191093] Starting subtest: allocator-basic [92.351406] Subtest allocator-basic: SUCCESS (0.151s) [92.454164] [041/171] (908s left) gem_softpin (allocator-basic-reserve) [92.605075] Starting subtest: allocator-basic-reserve [92.767495] Subtest allocator-basic-reserve: SUCCESS (0.154s) [92.887417] [042/171] (908s left) gem_softpin (safe-alignment) [93.027627] Starting subtest: safe-alignment [93.044388] Subtest safe-alignment: SUCCESS (0.017s) [93.169562] [043/171] (907s left) gem_sync (basic-all) [93.297472] Starting subtest: basic-all [95.805896] Subtest basic-all: SUCCESS (2.481s) [95.987250] [044/171] (905s left) gem_sync (basic-each) [96.125431] Starting subtest: basic-each [98.299687] Subtest basic-each: SUCCESS (2.175s) [98.504196] [045/171] (902s left) gem_tiled_blits (basic) [98.779348] Starting subtest: basic [98.808675] Subtest basic: SUCCESS (0.030s) [98.934885] [046/171] (902s left) gem_tiled_fence_blits (basic) [99.270273] Starting subtest: basic [99.297939] Subtest basic: SUCCESS (0.028s) [99.418317] [047/171] (901s left) gem_tiled_pread_basic [99.938789] [048/171] (901s left) gem_wait (busy@all-engines) [100.071607] Starting subtest: busy [100.072769] Starting dynamic subtest: all-engines [100.599672] Dynamic subtest all-engines: SUCCESS (0.528s) [100.600891] Subtest busy: SUCCESS (0.528s) [100.838379] [049/171] (900s left) gem_wait (wait@all-engines) [100.968998] Starting subtest: wait [100.970137] Starting dynamic subtest: all-engines [102.016415] Dynamic subtest all-engines: SUCCESS (1.046s) [102.018074] Subtest wait: SUCCESS (1.047s) [102.255427] [050/171] (899s left) i915_getparams_basic (basic-eu-total) [102.367965] Starting subtest: basic-eu-total [102.370331] Subtest basic-eu-total: SUCCESS (0.000s) [102.453336] [051/171] (898s left) i915_getparams_basic (basic-subslice-total) [102.565961] Starting subtest: basic-subslice-total [102.568402] Subtest basic-subslice-total: SUCCESS (0.000s) [102.653189] [052/171] (898s left) i915_hangman (error-state-basic) [102.778842] Starting subtest: error-state-basic [102.790744] Subtest error-state-basic: SUCCESS (0.013s) [102.870270] [053/171] (898s left) i915_pciid [103.070025] [054/171] (898s left) kms_addfb_basic (addfb25-bad-modifier) [103.216882] Starting subtest: addfb25-bad-modifier [103.218103] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [103.370355] [055/171] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [103.510413] Starting subtest: addfb25-framebuffer-vs-set-tiling [103.511569] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [103.653554] [056/171] (897s left) kms_addfb_basic (addfb25-modifier-no-flag) [103.793778] Starting subtest: addfb25-modifier-no-flag [103.794900] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [103.936751] [057/171] (897s left) kms_addfb_basic (addfb25-x-tiled-legacy) [104.076726] Starting subtest: addfb25-x-tiled-legacy [104.077808] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [104.220355] [058/171] (897s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [104.358332] Starting subtest: addfb25-x-tiled-mismatch-legacy [104.359335] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [104.503589] [059/171] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [104.667537] Starting subtest: addfb25-yf-tiled-legacy [104.668558] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [104.786796] [060/171] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [104.950471] Starting subtest: addfb25-y-tiled-legacy [104.951472] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [105.070406] [061/171] (896s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [105.234520] Starting subtest: addfb25-y-tiled-small-legacy [105.235521] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [105.353663] [062/171] (896s left) kms_addfb_basic (bad-pitch-0) [105.465774] Starting subtest: bad-pitch-0 [105.466918] Subtest bad-pitch-0: SUCCESS (0.000s) [105.636836] [063/171] (895s left) kms_addfb_basic (bad-pitch-1024) [105.748774] Starting subtest: bad-pitch-1024 [105.750011] Subtest bad-pitch-1024: SUCCESS (0.000s) [105.920573] [064/171] (895s left) kms_addfb_basic (bad-pitch-128) [106.031975] Starting subtest: bad-pitch-128 [106.033059] Subtest bad-pitch-128: SUCCESS (0.000s) [106.206631] [065/171] (895s left) kms_addfb_basic (bad-pitch-256) [106.335600] Starting subtest: bad-pitch-256 [106.336728] Subtest bad-pitch-256: SUCCESS (0.000s) [106.523928] [066/171] (895s left) kms_addfb_basic (bad-pitch-32) [106.651369] Starting subtest: bad-pitch-32 [106.652545] Subtest bad-pitch-32: SUCCESS (0.000s) [106.837127] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [106.949600] Starting subtest: bad-pitch-63 [106.950764] Subtest bad-pitch-63: SUCCESS (0.000s) [107.120125] [068/171] (894s left) kms_addfb_basic (bad-pitch-65536) [107.230878] Starting subtest: bad-pitch-65536 [107.232070] Subtest bad-pitch-65536: SUCCESS (0.000s) [107.403802] [069/171] (894s left) kms_addfb_basic (bad-pitch-999) [107.516541] Starting subtest: bad-pitch-999 [107.517620] Subtest bad-pitch-999: SUCCESS (0.000s) [107.689804] [070/171] (894s left) kms_addfb_basic (basic) [107.800773] Starting subtest: basic [107.802130] Subtest basic: SUCCESS (0.000s) [107.970222] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [108.158194] Starting subtest: basic-x-tiled-legacy [108.159345] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [108.254032] [072/171] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [108.442823] Starting subtest: basic-y-tiled-legacy [108.444013] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [108.553604] [073/171] (893s left) kms_addfb_basic (bo-too-small) [108.691313] Starting subtest: bo-too-small [108.692436] Subtest bo-too-small: SUCCESS (0.000s) [108.836929] [074/171] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling) [108.976266] Starting subtest: bo-too-small-due-to-tiling [108.977296] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [109.120117] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [109.239698] Starting subtest: clobberred-modifier [109.240746] Subtest clobberred-modifier: SUCCESS (0.000s) [109.408851] [076/171] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling) [109.602932] Starting subtest: framebuffer-vs-set-tiling [109.604174] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.703624] [077/171] (892s left) kms_addfb_basic (invalid-get-prop) [109.891656] Starting subtest: invalid-get-prop [109.892747] Subtest invalid-get-prop: SUCCESS (0.000s) [109.986864] [078/171] (892s left) kms_addfb_basic (invalid-get-prop-any) [110.179802] Starting subtest: invalid-get-prop-any [110.180967] Subtest invalid-get-prop-any: SUCCESS (0.000s) [110.287300] [079/171] (891s left) kms_addfb_basic (invalid-set-prop) [110.482777] Starting subtest: invalid-set-prop [110.483854] Subtest invalid-set-prop: SUCCESS (0.000s) [110.587056] [080/171] (891s left) kms_addfb_basic (invalid-set-prop-any) [110.783073] Starting subtest: invalid-set-prop-any [110.784091] Subtest invalid-set-prop-any: SUCCESS (0.000s) [110.870745] [081/171] (891s left) kms_addfb_basic (no-handle) [110.989610] Starting subtest: no-handle [110.990809] Subtest no-handle: SUCCESS (0.000s) [111.170392] [082/171] (890s left) kms_addfb_basic (size-max) [111.318267] Starting subtest: size-max [111.319270] Subtest size-max: SUCCESS (0.000s) [111.470492] [083/171] (890s left) kms_addfb_basic (small-bo) [111.619605] Starting subtest: small-bo [111.620781] Subtest small-bo: SUCCESS (0.000s) [111.774105] [084/171] (890s left) kms_addfb_basic (tile-pitch-mismatch) [111.971225] Starting subtest: tile-pitch-mismatch [111.972350] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [112.070457] [085/171] (890s left) kms_addfb_basic (too-high) [112.218645] Starting subtest: too-high [112.219675] Subtest too-high: SUCCESS (0.001s) [112.353435] [086/171] (889s left) kms_addfb_basic (too-wide) [112.490886] Starting subtest: too-wide [112.492150] Subtest too-wide: SUCCESS (0.000s) [112.636846] [087/171] (889s left) kms_addfb_basic (unused-handle) [112.758896] Starting subtest: unused-handle [112.760258] Subtest unused-handle: SUCCESS (0.000s) [112.920256] [088/171] (889s left) kms_addfb_basic (unused-modifier) [113.042929] Starting subtest: unused-modifier [113.044037] Subtest unused-modifier: SUCCESS (0.000s) [113.204091] [089/171] (889s left) kms_addfb_basic (unused-offsets) [113.325774] Starting subtest: unused-offsets [113.327011] Subtest unused-offsets: SUCCESS (0.000s) [113.503606] [090/171] (888s left) kms_addfb_basic (unused-pitches) [113.625631] Starting subtest: unused-pitches [113.626749] Subtest unused-pitches: SUCCESS (0.000s) [113.786936] [091/171] (888s left) kms_busy (basic) [113.938435] Starting subtest: basic [113.939589] Starting dynamic subtest: flip [114.922493] Dynamic subtest flip: SUCCESS (0.983s) [114.938531] Starting dynamic subtest: modeset [118.810872] Dynamic subtest modeset: SUCCESS (3.875s) [118.812421] Subtest basic: SUCCESS (4.860s) [119.713093] [092/171] (882s left) kms_chamelium_hpd (dp-hpd-fast) [120.160761] Subtest dp-hpd-fast: SKIP (0.000s) [121.072256] [093/171] (881s left) kms_chamelium_edid (dp-edid-read) [121.523757] Subtest dp-edid-read: SKIP (0.000s) [122.416742] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [122.866068] Subtest dp-crc-fast: SKIP (0.000s) [123.759940] [095/171] (878s left) kms_chamelium_hpd (hdmi-hpd-fast) [124.214501] Subtest hdmi-hpd-fast: SKIP (0.000s) [125.102834] [096/171] (877s left) kms_chamelium_edid (hdmi-edid-read) [125.553086] Subtest hdmi-edid-read: SKIP (0.000s) [126.448872] [097/171] (876s left) kms_chamelium_frames (hdmi-crc-fast) [126.901309] Subtest hdmi-crc-fast: SKIP (0.000s) [127.792562] [098/171] (874s left) kms_chamelium_hpd (vga-hpd-fast) [128.255601] Subtest vga-hpd-fast: SKIP (0.000s) [129.136432] [099/171] (873s left) kms_chamelium_edid (vga-edid-read) [129.587625] Subtest vga-edid-read: SKIP (0.000s) [130.479071] [100/171] (872s left) kms_prop_blob (basic) [130.592760] Starting subtest: basic [130.593867] Subtest basic: SUCCESS (0.000s) [130.679978] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [130.819352] Starting subtest: basic-busy-flip-before-cursor-atomic [130.821517] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [130.892445] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [131.043412] Starting subtest: basic-busy-flip-before-cursor-legacy [131.045536] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [131.126160] [103/171] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [131.279533] Starting subtest: basic-flip-after-cursor-atomic [132.572634] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.293s) [133.536446] [104/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [133.674325] Starting subtest: basic-flip-after-cursor-legacy [134.956825] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.282s) [135.904270] [105/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [136.045021] Starting subtest: basic-flip-after-cursor-varying-size [137.338323] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.288s) [138.270776] [106/171] (864s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [138.409324] Starting subtest: basic-flip-before-cursor-atomic [139.699042] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.289s) [140.639626] [107/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [140.778855] Starting subtest: basic-flip-before-cursor-legacy [142.070111] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.290s) [143.007649] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [143.147057] Starting subtest: basic-flip-before-cursor-varying-size [144.436889] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.290s) [145.374314] [109/171] (857s left) kms_flip (basic-flip-vs-dpms) [145.495159] Starting subtest: basic-flip-vs-dpms [145.498504] Starting dynamic subtest: A-eDP1 [148.388096] Dynamic subtest A-eDP1: SUCCESS (2.885s) [148.402967] Starting dynamic subtest: B-eDP1 [150.753242] Dynamic subtest B-eDP1: SUCCESS (2.369s) [150.769437] Starting dynamic subtest: C-eDP1 [153.129326] Dynamic subtest C-eDP1: SUCCESS (2.363s) [153.130384] Subtest basic-flip-vs-dpms: SUCCESS (7.625s) [154.080273] [110/171] (848s left) kms_flip (basic-flip-vs-modeset) [154.200706] Starting subtest: basic-flip-vs-modeset [154.204445] Starting dynamic subtest: A-eDP1 [157.082285] Dynamic subtest A-eDP1: SUCCESS (2.876s) [157.098951] Starting dynamic subtest: B-eDP1 [159.453827] Dynamic subtest B-eDP1: SUCCESS (2.370s) [159.469564] Starting dynamic subtest: C-eDP1 [161.821184] Dynamic subtest C-eDP1: SUCCESS (2.367s) [161.822615] Subtest basic-flip-vs-modeset: SUCCESS (7.622s) [162.784681] [111/171] (840s left) kms_flip (basic-flip-vs-wf_vblank) [162.914708] Starting subtest: basic-flip-vs-wf_vblank [162.917893] Starting dynamic subtest: A-eDP1 [165.251083] Dynamic subtest A-eDP1: SUCCESS (2.333s) [165.266835] Starting dynamic subtest: B-eDP1 [167.536463] Dynamic subtest B-eDP1: SUCCESS (2.284s) [167.552538] Starting dynamic subtest: C-eDP1 [169.778472] Dynamic subtest C-eDP1: SUCCESS (2.241s) [169.780946] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.868s) [171.103043] [112/171] (831s left) kms_flip (basic-plain-flip) [171.223122] Starting subtest: basic-plain-flip [171.226194] Starting dynamic subtest: A-eDP1 [173.287956] Dynamic subtest A-eDP1: SUCCESS (2.062s) [173.303783] Starting dynamic subtest: B-eDP1 [175.254354] Dynamic subtest B-eDP1: SUCCESS (1.965s) [175.270149] Starting dynamic subtest: C-eDP1 [177.238096] Dynamic subtest C-eDP1: SUCCESS (1.983s) [177.240571] Subtest basic-plain-flip: SUCCESS (6.019s) [178.591771] [113/171] (824s left) kms_force_connector_basic (force-connector-state) [178.711225] Starting subtest: force-connector-state [180.415156] Subtest force-connector-state: SUCCESS (1.704s) [181.027856] [114/171] (821s left) kms_force_connector_basic (force-edid) [181.154455] Starting subtest: force-edid [181.407082] Subtest force-edid: SUCCESS (0.253s) [181.527957] [115/171] (821s left) kms_force_connector_basic (force-load-detect) [181.650736] Starting subtest: force-load-detect [181.652977] Subtest force-load-detect: SKIP (0.000s) [181.777920] [116/171] (821s left) kms_force_connector_basic (prune-stale-modes) [181.898629] Starting subtest: prune-stale-modes [182.203860] Subtest prune-stale-modes: SUCCESS (0.304s) [182.311361] [117/171] (820s left) kms_frontbuffer_tracking (basic) [182.459186] Starting subtest: basic [185.779912] Subtest basic: SUCCESS (3.319s) [185.901229] [118/171] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [186.045923] Starting subtest: compare-crc-sanitycheck [186.047369] Starting dynamic subtest: pipe-A-eDP-1 [186.729063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s) [186.747912] Starting dynamic subtest: pipe-B-eDP-1 [188.079737] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s) [188.096709] Starting dynamic subtest: pipe-C-eDP-1 [189.619722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.536s) [189.620789] Subtest compare-crc-sanitycheck: SUCCESS (3.573s) [190.571571] [119/171] (812s left) kms_pipe_crc_basic (hang-read-crc) [190.713229] Starting subtest: hang-read-crc [190.716226] Starting dynamic subtest: pipe-A-eDP-1 [193.058579] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.343s) [193.075243] Starting dynamic subtest: pipe-B-eDP-1 [196.005022] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.942s) [196.020738] Starting dynamic subtest: pipe-C-eDP-1 [199.293776] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.288s) [199.294997] Subtest hang-read-crc: SUCCESS (8.581s) [200.240752] [120/171] (802s left) kms_pipe_crc_basic (nonblocking-crc) [200.396089] Starting subtest: nonblocking-crc [200.399295] Starting dynamic subtest: pipe-A-eDP-1 [201.264400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.864s) [201.279906] Starting dynamic subtest: pipe-B-eDP-1 [202.800345] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s) [202.816038] Starting dynamic subtest: pipe-C-eDP-1 [204.507180] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.703s) [204.508405] Subtest nonblocking-crc: SUCCESS (4.110s) [205.466967] [121/171] (797s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [205.609720] Starting subtest: nonblocking-crc-frame-sequence [205.612777] Starting dynamic subtest: pipe-A-eDP-1 [206.477648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.866s) [206.495195] Starting dynamic subtest: pipe-B-eDP-1 [208.034113] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s) [208.051983] Starting dynamic subtest: pipe-C-eDP-1 [209.755998] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.719s) [209.757069] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.147s) [210.714857] [122/171] (792s left) kms_pipe_crc_basic (read-crc) [210.856633] Starting subtest: read-crc [210.859630] Starting dynamic subtest: pipe-A-eDP-1 [211.660925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.801s) [211.677543] Starting dynamic subtest: pipe-B-eDP-1 [213.149807] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [213.165348] Starting dynamic subtest: pipe-C-eDP-1 [214.785458] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.634s) [214.786500] Subtest read-crc: SUCCESS (3.928s) [215.706860] [123/171] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence) [215.856816] Starting subtest: read-crc-frame-sequence [215.860065] Starting dynamic subtest: pipe-A-eDP-1 [216.651649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s) [216.668858] Starting dynamic subtest: pipe-B-eDP-1 [218.139142] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [218.155443] Starting dynamic subtest: pipe-C-eDP-1 [219.776757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.635s) [219.777813] Subtest read-crc-frame-sequence: SUCCESS (3.920s) [220.699025] [124/171] (782s left) kms_psr (primary_page_flip) [220.845548] Starting subtest: primary_page_flip [225.077560] Subtest primary_page_flip: SUCCESS (4.218s) [226.011243] [125/171] (777s left) kms_psr (cursor_plane_move) [226.155782] Starting subtest: cursor_plane_move [230.274470] Subtest cursor_plane_move: SUCCESS (4.117s) [231.195160] [126/171] (772s left) kms_psr (sprite_plane_onoff) [231.336648] Starting subtest: sprite_plane_onoff [235.569882] Subtest sprite_plane_onoff: SUCCESS (4.222s) [236.506756] [127/171] (766s left) kms_psr (primary_mmap_gtt) [236.649227] Starting subtest: primary_mmap_gtt [240.849047] Subtest primary_mmap_gtt: SUCCESS (4.200s) [241.754843] [128/171] (761s left) kms_setmode (basic-clone-single-crtc) [241.869381] Starting subtest: basic-clone-single-crtc [241.872404] Subtest basic-clone-single-crtc: SKIP (0.000s) [241.954779] [129/171] (761s left) i915_pm_backlight (basic-brightness) [242.094549] Starting subtest: basic-brightness [242.213495] Starting dynamic subtest: eDP-1 [242.768245] Dynamic subtest eDP-1: SUCCESS (0.561s) [242.769322] Subtest basic-brightness: SUCCESS (0.674s) [243.686891] [130/171] (759s left) i915_pm_rpm (basic-pci-d3-state) [245.545174] Starting subtest: basic-pci-d3-state [249.916257] Subtest basic-pci-d3-state: SUCCESS (4.365s) [250.111642] [131/171] (753s left) i915_pm_rpm (basic-rte) [250.222680] Starting subtest: basic-rte [256.376351] Subtest basic-rte: SUCCESS (6.152s) [261.682409] [132/171] (741s left) i915_pm_rps (basic-api) [261.803900] Starting subtest: basic-api [261.808103] Subtest basic-api: SUCCESS (0.004s) [261.898073] [133/171] (741s left) prime_self_import (basic-llseek-bad) [262.008484] Starting subtest: basic-llseek-bad [262.011895] Subtest basic-llseek-bad: SUCCESS (0.003s) [262.114613] [134/171] (741s left) prime_self_import (basic-llseek-size) [262.224784] Starting subtest: basic-llseek-size [262.228194] Subtest basic-llseek-size: SUCCESS (0.004s) [262.330965] [135/171] (741s left) prime_self_import (basic-with_fd_dup) [262.440686] Starting subtest: basic-with_fd_dup [262.446110] Subtest basic-with_fd_dup: SUCCESS (0.004s) [262.534869] [136/171] (740s left) prime_self_import (basic-with_one_bo) [262.653900] Starting subtest: basic-with_one_bo [262.659305] Subtest basic-with_one_bo: SUCCESS (0.005s) [262.749605] [137/171] (740s left) prime_self_import (basic-with_one_bo_two_files) [262.859912] Starting subtest: basic-with_one_bo_two_files [262.863405] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [262.969405] [138/171] (740s left) prime_self_import (basic-with_two_bos) [263.078253] Starting subtest: basic-with_two_bos [263.083498] Subtest basic-with_two_bos: SUCCESS (0.004s) [263.186038] [139/171] (740s left) prime_vgem (basic-fence-flip) [263.326688] Starting subtest: basic-fence-flip [263.846600] Subtest basic-fence-flip: SUCCESS (0.519s) [263.966439] [140/171] (739s left) prime_vgem (basic-fence-mmap) [264.087887] Starting subtest: basic-fence-mmap [264.129262] Subtest basic-fence-mmap: SUCCESS (0.041s) [264.256626] [141/171] (739s left) prime_vgem (basic-fence-read) [264.387608] Starting subtest: basic-fence-read [264.454950] Subtest basic-fence-read: SUCCESS (0.067s) [264.535834] [142/171] (739s left) prime_vgem (basic-gtt) [264.671269] Starting subtest: basic-gtt [264.693137] Subtest basic-gtt: SUCCESS (0.022s) [264.802437] [143/171] (738s left) prime_vgem (basic-read) [264.958924] Starting subtest: basic-read [264.992875] Subtest basic-read: SUCCESS (0.034s) [265.102590] [144/171] (738s left) prime_vgem (basic-write) [265.238472] Starting subtest: basic-write [265.278993] Subtest basic-write: SUCCESS (0.040s) [265.367054] [145/171] (738s left) prime_vgem (basic-userptr) [265.487505] Starting subtest: basic-userptr [265.502608] Subtest basic-userptr: SKIP (0.014s) [265.607648] [146/171] (738s left) vgem_basic (setversion) [265.730292] Starting subtest: setversion [265.732524] Subtest setversion: SUCCESS (0.000s) [265.803042] [147/171] (738s left) vgem_basic (create) [265.930326] Starting subtest: create [265.931549] Subtest create: SUCCESS (0.000s) [266.002136] [148/171] (737s left) vgem_basic (debugfs) [266.129946] Starting subtest: debugfs [266.131180] Subtest debugfs: SUCCESS (0.001s) [266.201901] [149/171] (737s left) vgem_basic (dmabuf-export) [266.330145] Starting subtest: dmabuf-export [266.333668] Subtest dmabuf-export: SUCCESS (0.003s) [266.436544] [150/171] (737s left) vgem_basic (dmabuf-fence) [266.565449] Starting subtest: dmabuf-fence [266.566529] Subtest dmabuf-fence: SUCCESS (0.001s) [266.631756] [151/171] (737s left) vgem_basic (dmabuf-fence-before) [266.765443] Starting subtest: dmabuf-fence-before [266.766525] Subtest dmabuf-fence-before: SUCCESS (0.000s) [266.832254] [152/171] (737s left) vgem_basic (dmabuf-mmap) [266.965368] Starting subtest: dmabuf-mmap [266.990074] Subtest dmabuf-mmap: SUCCESS (0.026s) [267.065211] [153/171] (736s left) vgem_basic (mmap) [267.198436] Starting subtest: mmap [267.214198] Subtest mmap: SUCCESS (0.016s) [267.282120] [154/171] (736s left) vgem_basic (second-client) [267.415418] Starting subtest: second-client [267.465429] Subtest second-client: SUCCESS (0.049s) [267.533641] [155/171] (736s left) vgem_basic (sysfs) [267.665186] Starting subtest: sysfs [267.666261] Subtest sysfs: SUCCESS (0.001s) [267.731796] [156/171] (736s left) core_hotunplug (unbind-rebind) [267.881489] Starting subtest: unbind-rebind [270.273272] Subtest unbind-rebind: SUCCESS (2.391s) [270.307525] [157/171] (733s left) vgem_basic (unload) [270.427141] Starting subtest: unload [299.280375] Subtest unload: SUCCESS (28.818s) [299.359432] [158/171] (704s left) i915_module_load (reload) [299.475662] Starting subtest: reload [302.641941] Subtest reload: SUCCESS (3.165s) [302.668850] [159/171] (701s left) gem_lmem_swapping (basic) [302.803463] Subtest basic: SKIP (0.000s) [302.857647] [160/171] (701s left) gem_lmem_swapping (parallel-random-engines) [302.985649] Subtest parallel-random-engines: SKIP (0.000s) [303.023477] [161/171] (701s left) gem_lmem_swapping (random-engines) [303.155021] Subtest random-engines: SKIP (0.000s) [303.209838] [162/171] (701s left) gem_lmem_swapping (verify-random) [303.340152] Subtest verify-random: SKIP (0.000s) [303.392176] [163/171] (700s left) i915_pm_rpm (module-reload) [315.876311] Starting subtest: module-reload [350.154659] Subtest module-reload: SUCCESS (34.272s) [350.174606] [164/171] (654s left) i915_selftest (live) [350.302111] Starting subtest: live [350.303436] Starting dynamic subtest: sanitycheck [352.078442] Dynamic subtest sanitycheck: SUCCESS (1.767s) [352.092753] Starting dynamic subtest: uncore [353.802506] Dynamic subtest uncore: SUCCESS (1.723s) [353.816683] Starting dynamic subtest: workarounds [355.737507] Dynamic subtest workarounds: SUCCESS (1.934s) [355.751846] Starting dynamic subtest: gt_engines [357.910574] Dynamic subtest gt_engines: SUCCESS (2.172s) [357.924851] Starting dynamic subtest: gt_timelines [369.720573] Dynamic subtest gt_timelines: SUCCESS (11.809s) [369.735087] Starting dynamic subtest: gt_contexts [371.640531] Dynamic subtest gt_contexts: SUCCESS (1.919s) [371.654994] Starting dynamic subtest: gt_lrc [375.916499] Dynamic subtest gt_lrc: SUCCESS (4.275s) [375.930841] Starting dynamic subtest: gt_mocs [377.743440] Dynamic subtest gt_mocs: SUCCESS (1.826s) [377.757819] Starting dynamic subtest: gt_pm [382.773589] Dynamic subtest gt_pm: SUCCESS (5.029s) [382.787911] Starting dynamic subtest: gt_heartbeat [384.667339] Dynamic subtest gt_heartbeat: SUCCESS (1.893s) [384.681787] Starting dynamic subtest: requests [392.203440] Dynamic subtest requests: SUCCESS (7.535s) [392.217843] Starting dynamic subtest: migrate [396.742521] Dynamic subtest migrate: SUCCESS (4.538s) [396.756965] Starting dynamic subtest: active [398.566302] Dynamic subtest active: SUCCESS (1.823s) [398.580784] Starting dynamic subtest: objects [401.873669] Dynamic subtest objects: SUCCESS (3.306s) [401.888148] Starting dynamic subtest: mman [408.708725] Dynamic subtest mman: SUCCESS (6.834s) [408.723173] Starting dynamic subtest: dmabuf [410.524464] Dynamic subtest dmabuf: SUCCESS (1.815s) [410.539020] Starting dynamic subtest: vma [412.255373] Dynamic subtest vma: SUCCESS (1.730s) [412.269958] Starting dynamic subtest: coherency [416.604597] Dynamic subtest coherency: SUCCESS (4.348s) [416.619172] Starting dynamic subtest: gtt [427.732471] Dynamic subtest gtt: SUCCESS (11.127s) [427.747182] Starting dynamic subtest: gem [429.610420] Dynamic subtest gem: SUCCESS (1.877s) [429.624925] Starting dynamic subtest: evict [433.183512] Dynamic subtest evict: SUCCESS (3.572s) [433.198123] Starting dynamic subtest: hugepages [440.034569] Dynamic subtest hugepages: SUCCESS (6.850s) [440.049507] Starting dynamic subtest: gem_contexts [454.969652] Dynamic subtest gem_contexts: SUCCESS (14.934s) [454.984575] Starting dynamic subtest: client [456.788548] Dynamic subtest client: SUCCESS (1.818s) [456.803434] Starting dynamic subtest: gem_migrate [458.522547] Dynamic subtest gem_migrate: SUCCESS (1.733s) [458.537380] Starting dynamic subtest: reset [463.856419] Dynamic subtest reset: SUCCESS (5.333s) [463.871329] Starting dynamic subtest: memory_region [465.618440] Dynamic subtest memory_region: SUCCESS (1.761s) [465.633428] Starting dynamic subtest: hangcheck [490.006576] Dynamic subtest hangcheck: SUCCESS (24.387s) [490.021802] Starting dynamic subtest: execlists [499.963501] Dynamic subtest execlists: SUCCESS (9.956s) [499.978527] Starting dynamic subtest: ring_submission [501.797508] Dynamic subtest ring_submission: SUCCESS (1.833s) [501.812464] Starting dynamic subtest: perf [503.632576] Dynamic subtest perf: SUCCESS (1.834s) [503.647496] Starting dynamic subtest: slpc [505.362701] Dynamic subtest slpc: SUCCESS (1.729s) [505.377753] Starting dynamic subtest: guc [507.090385] Dynamic subtest guc: SUCCESS (1.727s) [507.105329] Starting dynamic subtest: guc_multi_lrc [508.877486] Dynamic subtest guc_multi_lrc: SUCCESS (1.786s) [508.892416] Starting dynamic subtest: guc_hang [510.692523] Dynamic subtest guc_hang: SUCCESS (1.814s) [510.707521] Starting dynamic subtest: late_gt_pm [512.470458] Dynamic subtest late_gt_pm: SUCCESS (1.777s) [512.471790] Subtest live: SUCCESS (162.160s) [512.551806] [165/171] (491s left) dmabuf (all-tests) [512.671892] Starting subtest: all-tests [512.674118] Starting dynamic subtest: sanitycheck [512.694691] Dynamic subtest sanitycheck: SUCCESS (0.022s) [512.706859] Starting dynamic subtest: dma_fence [512.831797] Dynamic subtest dma_fence: SUCCESS (0.136s) [512.843331] Starting dynamic subtest: dma_fence_chain [530.350400] Dynamic subtest dma_fence_chain: SUCCESS (17.509s) [530.363419] Starting dynamic subtest: dma_fence_unwrap [530.369458] Dynamic subtest dma_fence_unwrap: SUCCESS (0.027s) [530.382030] Starting dynamic subtest: dma_resv [530.392515] Dynamic subtest dma_resv: SUCCESS (0.022s) [530.393656] Subtest all-tests: SUCCESS (17.721s) [530.416302] [166/171] (473s left) i915_suspend (basic-s2idle-without-i915) [530.528178] Starting subtest: basic-s2idle-without-i915 [553.184985] Subtest basic-s2idle-without-i915: SUCCESS (8.087s) [553.469870] [167/171] (465s left) i915_suspend (basic-s3-without-i915) [553.597388] Starting subtest: basic-s3-without-i915 [576.358845] Subtest basic-s3-without-i915: SUCCESS (7.033s) [576.622614] [168/171] (458s left) gem_exec_suspend (basic-s0) [576.762377] Starting subtest: basic-S0 [576.763593] Starting dynamic subtest: smem [596.354342] Dynamic subtest smem: SUCCESS (3.721s) [596.355340] Subtest basic-S0: SUCCESS (3.722s) [596.510941] [169/171] (454s left) gem_exec_suspend (basic-s3) [596.638244] Starting subtest: basic-S3 [596.639318] Starting dynamic subtest: smem [615.308631] Dynamic subtest smem: SUCCESS (3.502s) [615.309651] Subtest basic-S3: SUCCESS (3.503s) [615.457171] [170/171] (450s left) kms_chamelium_hpd (common-hpd-after-suspend) [615.914583] Subtest common-hpd-after-suspend: SKIP (0.000s) [616.780431] [171/171] (449s left) kms_pipe_crc_basic (suspend-read-crc) [616.924593] Starting subtest: suspend-read-crc [616.925682] Starting dynamic subtest: pipe-A-eDP-1 [634.313624] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.481s) [634.333757] Starting dynamic subtest: pipe-B-eDP-1 [652.264514] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.107s) [652.284113] Starting dynamic subtest: pipe-C-eDP-1 [671.264491] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.256s) [671.265606] Subtest suspend-read-crc: SUCCESS (8.854s) [672.185364] Closing watchdogs Done.