[43.543686] Initializing watchdogs [43.543822] /dev/watchdog0 [43.554116] [001/171] (960s left) i915_module_load (load) [43.620707] Starting subtest: load [44.687118] Subtest load: SUCCESS (1.066s) [44.721071] [002/171] (959s left) core_auth (basic-auth) [44.818816] Starting subtest: basic-auth [44.822815] Subtest basic-auth: SUCCESS (0.000s) [44.884813] [003/171] (959s left) debugfs_test (read_all_entries) [44.946377] Starting subtest: read_all_entries [45.070057] Subtest read_all_entries: SUCCESS (0.124s) [45.184133] [004/171] (958s left) debugfs_test (basic-hwmon) [45.237063] Starting subtest: basic-hwmon [45.243495] Subtest basic-hwmon: SKIP (0.000s) [45.334551] [005/171] (958s left) fbdev (eof) [45.403262] Starting subtest: eof [45.406765] Subtest eof: SUCCESS (0.000s) [45.468618] [006/171] (958s left) fbdev (info) [45.568414] Starting subtest: info [45.571860] Subtest info: SUCCESS (0.000s) [45.616472] [007/171] (958s left) fbdev (nullptr) [45.686560] Starting subtest: nullptr [45.690029] Subtest nullptr: SUCCESS (0.000s) [45.732229] [008/171] (958s left) fbdev (read) [45.786459] Starting subtest: read [46.002364] Subtest read: SUCCESS (0.216s) [46.048549] [009/171] (958s left) fbdev (write) [46.105236] Starting subtest: write [46.214430] Subtest write: SUCCESS (0.111s) [46.248870] [010/171] (957s left) gem_basic (bad-close) [46.303668] Starting subtest: bad-close [46.310182] Subtest bad-close: SUCCESS (0.000s) [46.350469] [011/171] (957s left) gem_basic (create-close) [46.410835] Starting subtest: create-close [46.417609] Subtest create-close: SUCCESS (0.000s) [46.496090] [012/171] (957s left) gem_basic (create-fd-close) [46.556660] Starting subtest: create-fd-close [46.563224] Subtest create-fd-close: SUCCESS (0.000s) [46.652754] [013/171] (957s left) gem_busy (busy@all-engines) [46.737331] Starting subtest: busy [46.740820] Starting dynamic subtest: all-engines [46.757704] Dynamic subtest all-engines: SUCCESS (0.020s) [46.761109] Subtest busy: SUCCESS (0.020s) [47.107526] [014/171] (957s left) gem_close_race (basic-process) [47.168750] Starting subtest: basic-process [47.216321] Subtest basic-process: SUCCESS (0.047s) [47.419422] [015/171] (956s left) gem_close_race (basic-threads) [47.520518] Starting subtest: basic-threads [48.710535] Subtest basic-threads: SUCCESS (1.190s) [48.920602] [016/171] (955s left) gem_ctx_create (basic) [49.079737] Starting subtest: basic [49.083128] Subtest basic: SUCCESS (0.000s) [49.286891] [017/171] (955s left) gem_ctx_create (basic-files) [49.373703] Starting subtest: basic-files [51.385060] Subtest basic-files: SUCCESS (2.011s) [51.778911] [018/171] (952s left) gem_ctx_exec (basic) [52.201971] Starting subtest: basic [52.267210] Subtest basic: SUCCESS (0.002s) [52.495501] [019/171] (952s left) gem_exec_basic (basic) [52.942603] Starting subtest: basic [52.945897] Starting dynamic subtest: rcs0-smem [52.949323] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [52.959407] Starting dynamic subtest: bcs0-smem [52.962836] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [52.969272] Starting dynamic subtest: vcs0-smem [52.972665] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [52.980061] Starting dynamic subtest: vecs0-smem [52.983394] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [52.986708] Subtest basic: SUCCESS (0.002s) [53.005308] [020/171] (951s left) gem_exec_create (basic) [53.083177] Starting subtest: basic [53.097226] Starting dynamic subtest: smem [55.148690] Dynamic subtest smem: SUCCESS (2.066s) [55.152149] Subtest basic: SUCCESS (2.066s) [55.354162] [021/171] (949s left) gem_exec_fence (basic-busy) [55.558391] Starting subtest: basic-busy [55.562994] Starting dynamic subtest: rcs0 [55.596762] Dynamic subtest rcs0: SUCCESS (0.038s) [55.607951] Starting dynamic subtest: bcs0 [55.635365] Dynamic subtest bcs0: SUCCESS (0.040s) [55.643357] Starting dynamic subtest: vcs0 [55.669712] Dynamic subtest vcs0: SUCCESS (0.034s) [55.690457] Starting dynamic subtest: vecs0 [55.713208] Dynamic subtest vecs0: SUCCESS (0.043s) [55.717249] Subtest basic-busy: SUCCESS (0.155s) [56.271161] [022/171] (948s left) gem_exec_fence (basic-wait) [56.454094] Starting subtest: basic-wait [56.457632] Starting dynamic subtest: rcs0 [56.495652] Dynamic subtest rcs0: SUCCESS (0.040s) [56.519078] Starting dynamic subtest: bcs0 [56.533643] Dynamic subtest bcs0: SUCCESS (0.038s) [56.557188] Starting dynamic subtest: vcs0 [56.570935] Dynamic subtest vcs0: SUCCESS (0.038s) [56.587696] Starting dynamic subtest: vecs0 [56.602804] Dynamic subtest vecs0: SUCCESS (0.032s) [56.606335] Subtest basic-wait: SUCCESS (0.148s) [57.140684] [023/171] (947s left) gem_exec_fence (basic-await) [57.334171] Starting subtest: basic-await [57.338505] Starting dynamic subtest: rcs0 [57.415725] Dynamic subtest rcs0: SUCCESS (0.082s) [57.424525] Starting dynamic subtest: bcs0 [57.487142] Dynamic subtest bcs0: SUCCESS (0.070s) [57.509392] Starting dynamic subtest: vcs0 [57.583225] Dynamic subtest vcs0: SUCCESS (0.097s) [57.592073] Starting dynamic subtest: vecs0 [57.655086] Dynamic subtest vecs0: SUCCESS (0.070s) [57.659395] Subtest basic-await: SUCCESS (0.321s) [58.188206] [024/171] (946s left) gem_exec_fence (nb-await) [58.371012] Starting subtest: nb-await [58.374176] Starting dynamic subtest: rcs0 [58.428326] Dynamic subtest rcs0: SUCCESS (0.056s) [58.451164] Starting dynamic subtest: bcs0 [58.500064] Dynamic subtest bcs0: SUCCESS (0.071s) [58.522632] Starting dynamic subtest: vcs0 [58.571994] Dynamic subtest vcs0: SUCCESS (0.071s) [58.594706] Starting dynamic subtest: vecs0 [58.642045] Dynamic subtest vecs0: SUCCESS (0.070s) [58.646268] Subtest nb-await: SUCCESS (0.270s) [59.117701] [025/171] (945s left) gem_exec_gttfill (basic) [59.176980] Starting subtest: basic [63.705350] Subtest basic: SUCCESS (4.529s) [63.866338] [026/171] (941s left) gem_exec_parallel (engines) [63.987139] Starting subtest: engines [63.990435] Starting dynamic subtest: basic [65.361577] Dynamic subtest basic: SUCCESS (1.374s) [65.368767] Starting dynamic subtest: contexts [67.723664] Dynamic subtest contexts: SUCCESS (2.362s) [67.731010] Starting dynamic subtest: fds [69.865203] Dynamic subtest fds: SUCCESS (2.142s) [69.872410] Starting dynamic subtest: userptr [71.467676] Dynamic subtest userptr: SUCCESS (1.598s) [71.471475] Subtest engines: SUCCESS (7.477s) [71.664715] [027/171] (933s left) gem_exec_store (basic) [71.781158] Starting subtest: basic [71.831030] Subtest basic: SUCCESS (0.052s) [72.021304] [028/171] (933s left) gem_flink_basic (bad-flink) [72.083317] Starting subtest: bad-flink [72.086349] Subtest bad-flink: SUCCESS (0.000s) [72.173192] [029/171] (932s left) gem_flink_basic (bad-open) [72.237349] Starting subtest: bad-open [72.240932] Subtest bad-open: SUCCESS (0.000s) [72.287528] [030/171] (932s left) gem_flink_basic (basic) [72.344184] Starting subtest: basic [72.347735] Subtest basic: SUCCESS (0.000s) [72.435702] [031/171] (932s left) gem_flink_basic (double-flink) [72.500064] Starting subtest: double-flink [72.503681] Subtest double-flink: SUCCESS (0.000s) [72.576719] [032/171] (932s left) gem_flink_basic (flink-lifetime) [72.665047] Starting subtest: flink-lifetime [72.668020] Subtest flink-lifetime: SUCCESS (0.000s) [72.739249] [033/171] (932s left) gem_huc_copy (huc-copy) [72.830128] Starting subtest: huc-copy [72.833187] Subtest huc-copy: SUCCESS (0.002s) [72.940563] [034/171] (932s left) gem_linear_blits (basic) [73.069197] Starting subtest: basic [73.075445] Subtest basic: SUCCESS (0.004s) [73.239421] [035/171] (932s left) gem_mmap (basic) [73.377975] Starting subtest: basic [73.394052] Subtest basic: SUCCESS (0.000s) [73.487192] [036/171] (931s left) gem_mmap_gtt (basic) [73.577853] Starting subtest: basic [73.581092] Subtest basic: SUCCESS (0.000s) [73.629614] [037/171] (931s left) gem_render_linear_blits (basic) [73.700100] Starting subtest: basic [73.718715] Subtest basic: SUCCESS (0.017s) [73.762661] [038/171] (931s left) gem_render_tiled_blits (basic) [73.820138] Starting subtest: basic [73.838618] Subtest basic: SUCCESS (0.021s) [73.879196] [039/171] (931s left) gem_ringfill (basic-all) [74.143115] Starting subtest: basic-all [75.274651] Subtest basic-all: SUCCESS (1.136s) [75.390329] [040/171] (930s left) gem_softpin (allocator-basic) [75.446333] Starting subtest: allocator-basic [75.498101] Subtest allocator-basic: SUCCESS (0.055s) [75.587979] [041/171] (929s left) gem_softpin (allocator-basic-reserve) [75.642815] Starting subtest: allocator-basic-reserve [75.695189] Subtest allocator-basic-reserve: SUCCESS (0.055s) [75.798481] [042/171] (929s left) gem_softpin (safe-alignment) [75.863030] Starting subtest: safe-alignment [75.869280] Subtest safe-alignment: SUCCESS (0.006s) [75.990655] [043/171] (929s left) gem_sync (basic-all) [76.077326] Starting subtest: basic-all [78.127489] Subtest basic-all: SUCCESS (2.073s) [78.328902] [044/171] (927s left) gem_sync (basic-each) [78.418184] Starting subtest: basic-each [80.453780] Subtest basic-each: SUCCESS (2.058s) [80.658307] [045/171] (924s left) gem_tiled_blits (basic) [80.819248] Starting subtest: basic [80.831646] Subtest basic: SUCCESS (0.013s) [80.979314] [046/171] (924s left) gem_tiled_fence_blits (basic) [81.224704] Starting subtest: basic [81.231622] Subtest basic: SUCCESS (0.006s) [81.387444] [047/171] (924s left) gem_tiled_pread_basic [81.703669] [048/171] (924s left) gem_wait (busy@all-engines) [81.759400] Starting subtest: busy [81.762621] Starting dynamic subtest: all-engines [82.274350] Dynamic subtest all-engines: SUCCESS (0.515s) [82.277702] Subtest busy: SUCCESS (0.515s) [82.467987] [049/171] (923s left) gem_wait (wait@all-engines) [82.523674] Starting subtest: wait [82.526824] Starting dynamic subtest: all-engines [83.557531] Dynamic subtest all-engines: SUCCESS (1.033s) [83.561790] Subtest wait: SUCCESS (1.033s) [83.764805] [050/171] (921s left) i915_getparams_basic (basic-eu-total) [83.817187] Starting subtest: basic-eu-total [83.823877] Subtest basic-eu-total: SUCCESS (0.000s) [83.907312] [051/171] (921s left) i915_getparams_basic (basic-subslice-total) [83.999641] Starting subtest: basic-subslice-total [84.006306] Subtest basic-subslice-total: SUCCESS (0.000s) [84.051277] [052/171] (921s left) i915_hangman (error-state-basic) [84.126423] Starting subtest: error-state-basic [84.177042] Subtest error-state-basic: SUCCESS (0.049s) [84.234348] [053/171] (921s left) i915_pciid [84.372222] [054/171] (921s left) kms_addfb_basic (addfb25-bad-modifier) [84.485725] Starting subtest: addfb25-bad-modifier [84.488874] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [84.652377] [055/171] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [84.752439] Starting subtest: addfb25-framebuffer-vs-set-tiling [84.781773] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.919738] [056/171] (920s left) kms_addfb_basic (addfb25-modifier-no-flag) [85.020117] Starting subtest: addfb25-modifier-no-flag [85.023385] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [85.185732] [057/171] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy) [85.284326] Starting subtest: addfb25-x-tiled-legacy [85.287569] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [85.451499] [058/171] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [85.549748] Starting subtest: addfb25-x-tiled-mismatch-legacy [85.552747] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [85.718155] [059/171] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [85.862844] Starting subtest: addfb25-yf-tiled-legacy [85.865801] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [85.987284] [060/171] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy) [86.142818] Starting subtest: addfb25-y-tiled-legacy [86.146178] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [86.254317] [061/171] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [86.401257] Starting subtest: addfb25-y-tiled-small-legacy [86.404615] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [86.520343] [062/171] (919s left) kms_addfb_basic (bad-pitch-0) [86.573304] Starting subtest: bad-pitch-0 [86.576491] Subtest bad-pitch-0: SUCCESS (0.000s) [86.803656] [063/171] (919s left) kms_addfb_basic (bad-pitch-1024) [86.858612] Starting subtest: bad-pitch-1024 [86.861847] Subtest bad-pitch-1024: SUCCESS (0.000s) [87.070400] [064/171] (918s left) kms_addfb_basic (bad-pitch-128) [87.125065] Starting subtest: bad-pitch-128 [87.128359] Subtest bad-pitch-128: SUCCESS (0.000s) [87.372164] [065/171] (918s left) kms_addfb_basic (bad-pitch-256) [87.422656] Starting subtest: bad-pitch-256 [87.426078] Subtest bad-pitch-256: SUCCESS (0.000s) [87.636158] [066/171] (918s left) kms_addfb_basic (bad-pitch-32) [87.697186] Starting subtest: bad-pitch-32 [87.700277] Subtest bad-pitch-32: SUCCESS (0.000s) [87.903782] [067/171] (918s left) kms_addfb_basic (bad-pitch-63) [87.958306] Starting subtest: bad-pitch-63 [87.961502] Subtest bad-pitch-63: SUCCESS (0.000s) [88.170299] [068/171] (917s left) kms_addfb_basic (bad-pitch-65536) [88.228365] Starting subtest: bad-pitch-65536 [88.231614] Subtest bad-pitch-65536: SUCCESS (0.000s) [88.435703] [069/171] (917s left) kms_addfb_basic (bad-pitch-999) [88.488117] Starting subtest: bad-pitch-999 [88.491412] Subtest bad-pitch-999: SUCCESS (0.000s) [88.718914] [070/171] (917s left) kms_addfb_basic (basic) [88.770699] Starting subtest: basic [88.773892] Subtest basic: SUCCESS (0.000s) [88.985266] [071/171] (917s left) kms_addfb_basic (basic-x-tiled-legacy) [89.175800] Starting subtest: basic-x-tiled-legacy [89.178653] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [89.251750] [072/171] (916s left) kms_addfb_basic (basic-y-tiled-legacy) [89.443017] Starting subtest: basic-y-tiled-legacy [89.446031] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [89.535264] [073/171] (916s left) kms_addfb_basic (bo-too-small) [89.633858] Starting subtest: bo-too-small [89.636975] Subtest bo-too-small: SUCCESS (0.000s) [89.802656] [074/171] (916s left) kms_addfb_basic (bo-too-small-due-to-tiling) [89.899779] Starting subtest: bo-too-small-due-to-tiling [89.902657] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [90.069419] [075/171] (916s left) kms_addfb_basic (clobberred-modifier) [90.121520] Starting subtest: clobberred-modifier [90.124721] Subtest clobberred-modifier: SUCCESS (0.000s) [90.335604] [076/171] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling) [90.540175] Starting subtest: framebuffer-vs-set-tiling [90.543094] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [90.602116] [077/171] (915s left) kms_addfb_basic (invalid-get-prop) [90.796068] Starting subtest: invalid-get-prop [90.798797] Subtest invalid-get-prop: SUCCESS (0.000s) [90.868327] [078/171] (915s left) kms_addfb_basic (invalid-get-prop-any) [91.056856] Starting subtest: invalid-get-prop-any [91.059632] Subtest invalid-get-prop-any: SUCCESS (0.000s) [91.135763] [079/171] (915s left) kms_addfb_basic (invalid-set-prop) [91.329189] Starting subtest: invalid-set-prop [91.332340] Subtest invalid-set-prop: SUCCESS (0.000s) [91.418743] [080/171] (914s left) kms_addfb_basic (invalid-set-prop-any) [91.612279] Starting subtest: invalid-set-prop-any [91.615441] Subtest invalid-set-prop-any: SUCCESS (0.000s) [91.685622] [081/171] (914s left) kms_addfb_basic (no-handle) [91.736920] Starting subtest: no-handle [91.739692] Subtest no-handle: SUCCESS (0.000s) [91.951428] [082/171] (914s left) kms_addfb_basic (size-max) [92.052781] Starting subtest: size-max [92.055557] Subtest size-max: SUCCESS (0.000s) [92.218671] [083/171] (914s left) kms_addfb_basic (small-bo) [92.316896] Starting subtest: small-bo [92.319641] Subtest small-bo: SUCCESS (0.000s) [92.485818] [084/171] (913s left) kms_addfb_basic (tile-pitch-mismatch) [92.677254] Starting subtest: tile-pitch-mismatch [92.680461] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [92.752392] [085/171] (913s left) kms_addfb_basic (too-high) [92.858987] Starting subtest: too-high [92.861908] Subtest too-high: SUCCESS (0.000s) [93.035460] [086/171] (913s left) kms_addfb_basic (too-wide) [93.131810] Starting subtest: too-wide [93.134611] Subtest too-wide: SUCCESS (0.000s) [93.303082] [087/171] (913s left) kms_addfb_basic (unused-handle) [93.355678] Starting subtest: unused-handle [93.358918] Subtest unused-handle: SUCCESS (0.000s) [93.570307] [088/171] (912s left) kms_addfb_basic (unused-modifier) [93.622726] Starting subtest: unused-modifier [93.625968] Subtest unused-modifier: SUCCESS (0.000s) [93.835838] [089/171] (912s left) kms_addfb_basic (unused-offsets) [93.886949] Starting subtest: unused-offsets [93.890109] Subtest unused-offsets: SUCCESS (0.000s) [94.106155] [090/171] (912s left) kms_addfb_basic (unused-pitches) [94.159284] Starting subtest: unused-pitches [94.162546] Subtest unused-pitches: SUCCESS (0.000s) [94.369244] [091/171] (912s left) kms_busy (basic) [94.473044] Starting subtest: basic [94.476332] Starting dynamic subtest: flip [95.004023] Dynamic subtest flip: SUCCESS (0.467s) [95.068435] Starting dynamic subtest: modeset [95.555667] Dynamic subtest modeset: SUCCESS (0.529s) [95.621065] Subtest basic: SUCCESS (0.997s) [95.916533] [092/171] (910s left) kms_chamelium_hpd (dp-hpd-fast) [96.345060] Subtest dp-hpd-fast: SKIP (0.000s) [96.368781] [093/171] (910s left) kms_chamelium_edid (dp-edid-read) [96.831306] Subtest dp-edid-read: SKIP (0.000s) [97.137391] [094/171] (909s left) kms_chamelium_frames (dp-crc-fast) [97.654059] Subtest dp-crc-fast: SKIP (0.000s) [97.943937] [095/171] (909s left) kms_chamelium_hpd (hdmi-hpd-fast) [98.376675] Subtest hdmi-hpd-fast: SKIP (0.000s) [98.669051] [096/171] (908s left) kms_chamelium_edid (hdmi-edid-read) [99.127782] Subtest hdmi-edid-read: SKIP (0.000s) [99.449783] [097/171] (908s left) kms_chamelium_frames (hdmi-crc-fast) [99.616667] Subtest hdmi-crc-fast: SKIP (0.000s) [99.685837] [098/171] (908s left) kms_chamelium_hpd (vga-hpd-fast) [99.840789] Subtest vga-hpd-fast: SKIP (0.000s) [99.908222] [099/171] (907s left) kms_chamelium_edid (vga-edid-read) [100.067942] Subtest vga-edid-read: SKIP (0.000s) [100.133940] [100/171] (907s left) kms_prop_blob (basic) [100.189014] Starting subtest: basic [100.191994] Subtest basic: SUCCESS (0.000s) [100.251148] [101/171] (907s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [100.353602] Starting subtest: basic-busy-flip-before-cursor-atomic [100.359657] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [100.419264] [102/171] (907s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [100.519938] Starting subtest: basic-busy-flip-before-cursor-legacy [100.526507] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [100.586424] [103/171] (907s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [100.686964] Starting subtest: basic-flip-after-cursor-atomic [101.639700] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.954s) [101.765852] [104/171] (906s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [101.865525] Starting subtest: basic-flip-after-cursor-legacy [102.815333] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.950s) [102.934816] [105/171] (904s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [103.034430] Starting subtest: basic-flip-after-cursor-varying-size [103.973914] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.939s) [104.094678] [106/171] (903s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [104.193248] Starting subtest: basic-flip-before-cursor-atomic [105.150855] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.958s) [105.272911] [107/171] (902s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [105.371367] Starting subtest: basic-flip-before-cursor-legacy [106.310932] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.939s) [106.430645] [108/171] (901s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [106.531354] Starting subtest: basic-flip-before-cursor-varying-size [107.484722] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.953s) [107.606956] [109/171] (900s left) kms_flip (basic-flip-vs-dpms) [107.699431] Starting subtest: basic-flip-vs-dpms [107.702636] Starting dynamic subtest: A-HDMI-A1 [108.646703] Dynamic subtest A-HDMI-A1: SUCCESS (0.949s) [108.654351] Starting dynamic subtest: B-HDMI-A1 [109.530853] Dynamic subtest B-HDMI-A1: SUCCESS (0.883s) [109.538782] Starting dynamic subtest: C-HDMI-A1 [110.418819] Dynamic subtest C-HDMI-A1: SUCCESS (0.888s) [110.422073] Subtest basic-flip-vs-dpms: SUCCESS (2.724s) [110.552288] [110/171] (897s left) kms_flip (basic-flip-vs-modeset) [110.647914] Starting subtest: basic-flip-vs-modeset [110.651049] Starting dynamic subtest: A-HDMI-A1 [111.500826] Dynamic subtest A-HDMI-A1: SUCCESS (0.854s) [111.508675] Starting dynamic subtest: B-HDMI-A1 [112.283111] Dynamic subtest B-HDMI-A1: SUCCESS (0.782s) [112.290813] Starting dynamic subtest: C-HDMI-A1 [113.065261] Dynamic subtest C-HDMI-A1: SUCCESS (0.781s) [113.068369] Subtest basic-flip-vs-modeset: SUCCESS (2.422s) [113.189410] [111/171] (894s left) kms_flip (basic-flip-vs-wf_vblank) [113.284356] Starting subtest: basic-flip-vs-wf_vblank [113.287609] Starting dynamic subtest: A-HDMI-A1 [114.427085] Dynamic subtest A-HDMI-A1: SUCCESS (1.145s) [114.434903] Starting dynamic subtest: B-HDMI-A1 [115.549399] Dynamic subtest B-HDMI-A1: SUCCESS (1.122s) [115.557284] Starting dynamic subtest: C-HDMI-A1 [116.684361] Dynamic subtest C-HDMI-A1: SUCCESS (1.134s) [116.687410] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.406s) [116.872213] [112/171] (891s left) kms_flip (basic-plain-flip) [116.968067] Starting subtest: basic-plain-flip [116.971258] Starting dynamic subtest: A-HDMI-A1 [117.825790] Dynamic subtest A-HDMI-A1: SUCCESS (0.860s) [117.833708] Starting dynamic subtest: B-HDMI-A1 [118.662441] Dynamic subtest B-HDMI-A1: SUCCESS (0.836s) [118.670355] Starting dynamic subtest: C-HDMI-A1 [119.500957] Dynamic subtest C-HDMI-A1: SUCCESS (0.836s) [119.504143] Subtest basic-plain-flip: SUCCESS (2.537s) [119.686194] [113/171] (888s left) kms_force_connector_basic (force-connector-state) [119.838812] Starting subtest: force-connector-state [120.114767] Subtest force-connector-state: SUCCESS (0.276s) [120.518630] [114/171] (887s left) kms_force_connector_basic (force-edid) [120.671484] Starting subtest: force-edid [120.812171] Subtest force-edid: SUCCESS (0.141s) [121.001531] [115/171] (887s left) kms_force_connector_basic (force-load-detect) [121.152966] Starting subtest: force-load-detect [121.159139] Subtest force-load-detect: SKIP (0.000s) [121.351501] [116/171] (886s left) kms_force_connector_basic (prune-stale-modes) [121.501989] Starting subtest: prune-stale-modes [121.638019] Subtest prune-stale-modes: SUCCESS (0.136s) [121.835073] [117/171] (886s left) kms_frontbuffer_tracking (basic) [121.946717] Starting subtest: basic [124.284742] Subtest basic: SUCCESS (2.347s) [124.392915] [118/171] (883s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [124.536294] Starting subtest: compare-crc-sanitycheck [124.539555] Starting dynamic subtest: pipe-A-HDMI-A-1 [124.922534] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.385s) [124.930464] Starting dynamic subtest: pipe-B-HDMI-A-1 [125.287210] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.364s) [125.294822] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.653652] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.365s) [125.656854] Subtest compare-crc-sanitycheck: SUCCESS (1.117s) [125.780024] [119/171] (882s left) kms_pipe_crc_basic (hang-read-crc) [125.880377] Starting subtest: hang-read-crc [125.883616] Starting dynamic subtest: pipe-A-HDMI-A-1 [126.799173] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.918s) [126.807180] Starting dynamic subtest: pipe-B-HDMI-A-1 [127.705822] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.906s) [127.713910] Starting dynamic subtest: pipe-C-HDMI-A-1 [128.597884] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.891s) [128.601285] Subtest hang-read-crc: SUCCESS (2.718s) [128.697516] [120/171] (879s left) kms_pipe_crc_basic (nonblocking-crc) [128.798485] Starting subtest: nonblocking-crc [128.801696] Starting dynamic subtest: pipe-A-HDMI-A-1 [129.319112] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.519s) [129.327282] Starting dynamic subtest: pipe-B-HDMI-A-1 [129.811821] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.492s) [129.820084] Starting dynamic subtest: pipe-C-HDMI-A-1 [130.322834] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.510s) [130.326176] Subtest nonblocking-crc: SUCCESS (1.524s) [130.422673] [121/171] (877s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [130.522576] Starting subtest: nonblocking-crc-frame-sequence [130.525905] Starting dynamic subtest: pipe-A-HDMI-A-1 [131.044505] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.521s) [131.054199] Starting dynamic subtest: pipe-B-HDMI-A-1 [131.538765] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.494s) [131.546826] Starting dynamic subtest: pipe-C-HDMI-A-1 [132.034144] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.494s) [132.037396] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.512s) [132.184164] [122/171] (876s left) kms_pipe_crc_basic (read-crc) [132.285295] Starting subtest: read-crc [132.288347] Starting dynamic subtest: pipe-A-HDMI-A-1 [132.738705] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.453s) [132.746621] Starting dynamic subtest: pipe-B-HDMI-A-1 [133.164446] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.425s) [133.172149] Starting dynamic subtest: pipe-C-HDMI-A-1 [133.591874] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.426s) [133.595177] Subtest read-crc: SUCCESS (1.306s) [133.692158] [123/171] (874s left) kms_pipe_crc_basic (read-crc-frame-sequence) [133.819567] Starting subtest: read-crc-frame-sequence [133.822989] Starting dynamic subtest: pipe-A-HDMI-A-1 [134.379053] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.462s) [134.444298] Starting dynamic subtest: pipe-B-HDMI-A-1 [134.770811] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.424s) [134.835935] Starting dynamic subtest: pipe-C-HDMI-A-1 [135.196011] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.427s) [135.261873] Subtest read-crc-frame-sequence: SUCCESS (1.315s) [135.522837] [124/171] (872s left) kms_psr (primary_page_flip) [135.592584] Subtest primary_page_flip: SKIP (0.000s) [135.609857] [125/171] (872s left) kms_psr (cursor_plane_move) [135.663325] Subtest cursor_plane_move: SKIP (0.000s) [135.680860] [126/171] (872s left) kms_psr (sprite_plane_onoff) [135.738789] Subtest sprite_plane_onoff: SKIP (0.000s) [135.759733] [127/171] (872s left) kms_psr (primary_mmap_gtt) [135.814700] Subtest primary_mmap_gtt: SKIP (0.000s) [135.832325] [128/171] (872s left) kms_setmode (basic-clone-single-crtc) [135.889092] Starting subtest: basic-clone-single-crtc [135.899333] Subtest basic-clone-single-crtc: SKIP (0.000s) [135.955601] [129/171] (872s left) i915_pm_backlight (basic-brightness) [136.086748] Subtest basic-brightness: SKIP (0.000s) [136.112378] [130/171] (872s left) i915_pm_rpm (basic-pci-d3-state) [137.640584] Starting subtest: basic-pci-d3-state [138.100720] Subtest basic-pci-d3-state: SUCCESS (0.458s) [138.576714] [131/171] (870s left) i915_pm_rpm (basic-rte) [138.634755] Starting subtest: basic-rte [140.447905] Subtest basic-rte: SUCCESS (1.816s) [141.375895] [132/171] (867s left) i915_pm_rps (basic-api) [141.434509] Starting subtest: basic-api [141.438124] Subtest basic-api: SUCCESS (0.002s) [141.493777] [133/171] (867s left) prime_self_import (basic-llseek-bad) [141.547036] Starting subtest: basic-llseek-bad [141.550454] Subtest basic-llseek-bad: SUCCESS (0.001s) [141.649881] [134/171] (867s left) prime_self_import (basic-llseek-size) [141.743225] Starting subtest: basic-llseek-size [141.746459] Subtest basic-llseek-size: SUCCESS (0.001s) [141.812366] [135/171] (866s left) prime_self_import (basic-with_fd_dup) [141.870833] Starting subtest: basic-with_fd_dup [141.874336] Subtest basic-with_fd_dup: SUCCESS (0.001s) [141.985865] [136/171] (866s left) prime_self_import (basic-with_one_bo) [142.078805] Starting subtest: basic-with_one_bo [142.082067] Subtest basic-with_one_bo: SUCCESS (0.002s) [142.138365] [137/171] (866s left) prime_self_import (basic-with_one_bo_two_files) [142.190922] Starting subtest: basic-with_one_bo_two_files [142.194323] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [142.301776] [138/171] (866s left) prime_self_import (basic-with_two_bos) [142.394057] Starting subtest: basic-with_two_bos [142.397211] Subtest basic-with_two_bos: SUCCESS (0.001s) [142.477867] [139/171] (866s left) prime_vgem (basic-fence-flip) [142.600576] Starting subtest: basic-fence-flip [142.993633] Subtest basic-fence-flip: SUCCESS (0.393s) [143.096717] [140/171] (865s left) prime_vgem (basic-fence-mmap) [143.172442] Starting subtest: basic-fence-mmap [143.184480] Subtest basic-fence-mmap: SUCCESS (0.013s) [143.320368] [141/171] (865s left) prime_vgem (basic-fence-read) [143.409715] Starting subtest: basic-fence-read [143.431238] Subtest basic-fence-read: SUCCESS (0.023s) [143.570587] [142/171] (865s left) prime_vgem (basic-gtt) [143.663546] Starting subtest: basic-gtt [143.670032] Subtest basic-gtt: SUCCESS (0.007s) [143.749959] [143/171] (865s left) prime_vgem (basic-read) [143.837842] Starting subtest: basic-read [143.846962] Subtest basic-read: SUCCESS (0.011s) [143.954367] [144/171] (865s left) prime_vgem (basic-write) [144.079080] Starting subtest: basic-write [144.105137] Subtest basic-write: SUCCESS (0.027s) [144.185146] [145/171] (864s left) prime_vgem (basic-userptr) [144.290569] Starting subtest: basic-userptr [144.296871] Subtest basic-userptr: SKIP (0.004s) [144.429439] [146/171] (864s left) vgem_basic (setversion) [144.528010] Starting subtest: setversion [144.534496] Subtest setversion: SUCCESS (0.000s) [144.575605] [147/171] (864s left) vgem_basic (create) [144.659368] Starting subtest: create [144.662726] Subtest create: SUCCESS (0.000s) [144.710773] [148/171] (864s left) vgem_basic (debugfs) [144.778766] Starting subtest: debugfs [144.783173] Subtest debugfs: SUCCESS (0.001s) [144.857092] [149/171] (864s left) vgem_basic (dmabuf-export) [144.925687] Starting subtest: dmabuf-export [144.941750] Subtest dmabuf-export: SUCCESS (0.016s) [145.070173] [150/171] (864s left) vgem_basic (dmabuf-fence) [145.142460] Starting subtest: dmabuf-fence [145.146103] Subtest dmabuf-fence: SUCCESS (0.000s) [145.195687] [151/171] (864s left) vgem_basic (dmabuf-fence-before) [145.276599] Starting subtest: dmabuf-fence-before [145.279992] Subtest dmabuf-fence-before: SUCCESS (0.000s) [145.351505] [152/171] (864s left) vgem_basic (dmabuf-mmap) [145.459105] Starting subtest: dmabuf-mmap [145.467217] Subtest dmabuf-mmap: SUCCESS (0.008s) [145.507481] [153/171] (863s left) vgem_basic (mmap) [145.575657] Starting subtest: mmap [145.582530] Subtest mmap: SUCCESS (0.005s) [145.623287] [154/171] (863s left) vgem_basic (second-client) [145.678912] Starting subtest: second-client [145.725591] Subtest second-client: SUCCESS (0.050s) [145.798727] [155/171] (863s left) vgem_basic (sysfs) [145.859261] Starting subtest: sysfs [145.862812] Subtest sysfs: SUCCESS (0.000s) [145.912914] [156/171] (863s left) core_hotunplug (unbind-rebind) [146.008981] Starting subtest: unbind-rebind [146.964408] Subtest unbind-rebind: SUCCESS (0.955s) [146.999320] [157/171] (862s left) vgem_basic (unload) [147.055305] Starting subtest: unload [175.758167] Subtest unload: SUCCESS (28.703s) [175.836514] [158/171] (833s left) i915_module_load (reload) [175.895674] Starting subtest: reload [177.653618] Subtest reload: SUCCESS (1.759s) [177.679459] [159/171] (831s left) gem_lmem_swapping (basic) [177.754307] Subtest basic: SKIP (0.000s) [177.780871] [160/171] (831s left) gem_lmem_swapping (parallel-random-engines) [177.839431] Subtest parallel-random-engines: SKIP (0.000s) [177.864419] [161/171] (831s left) gem_lmem_swapping (random-engines) [177.922988] Subtest random-engines: SKIP (0.000s) [177.945754] [162/171] (831s left) gem_lmem_swapping (verify-random) [178.005177] Subtest verify-random: SKIP (0.000s) [178.031305] [163/171] (831s left) i915_pm_rpm (module-reload) [179.743910] Starting subtest: module-reload [187.063451] Subtest module-reload: SUCCESS (7.323s) [187.081946] [164/171] (822s left) i915_selftest (live) [187.146818] Starting subtest: live [187.150046] Starting dynamic subtest: sanitycheck [187.596339] Dynamic subtest sanitycheck: SUCCESS (0.450s) [187.603281] Starting dynamic subtest: uncore [188.072345] Dynamic subtest uncore: SUCCESS (0.476s) [188.079051] Starting dynamic subtest: workarounds [188.678315] Dynamic subtest workarounds: SUCCESS (0.606s) [188.685058] Starting dynamic subtest: gt_engines [189.632275] Dynamic subtest gt_engines: SUCCESS (0.954s) [189.639227] Starting dynamic subtest: gt_timelines [195.224282] Dynamic subtest gt_timelines: SUCCESS (5.592s) [195.230994] Starting dynamic subtest: gt_contexts [195.774246] Dynamic subtest gt_contexts: SUCCESS (0.550s) [195.783298] Starting dynamic subtest: gt_lrc [198.564296] Dynamic subtest gt_lrc: SUCCESS (2.790s) [198.571139] Starting dynamic subtest: gt_mocs [199.118279] Dynamic subtest gt_mocs: SUCCESS (0.554s) [199.125136] Starting dynamic subtest: gt_pm [201.482479] Dynamic subtest gt_pm: SUCCESS (2.364s) [201.489203] Starting dynamic subtest: gt_heartbeat [202.063088] Dynamic subtest gt_heartbeat: SUCCESS (0.581s) [202.072109] Starting dynamic subtest: requests [208.734363] Dynamic subtest requests: SUCCESS (6.671s) [208.741249] Starting dynamic subtest: migrate [212.080353] Dynamic subtest migrate: SUCCESS (3.346s) [212.087178] Starting dynamic subtest: active [212.538592] Dynamic subtest active: SUCCESS (0.458s) [212.545556] Starting dynamic subtest: objects [213.546149] Dynamic subtest objects: SUCCESS (1.008s) [213.553127] Starting dynamic subtest: mman [217.306358] Dynamic subtest mman: SUCCESS (3.760s) [217.313229] Starting dynamic subtest: dmabuf [217.895897] Dynamic subtest dmabuf: SUCCESS (0.537s) [217.961106] Starting dynamic subtest: vma [218.353632] Dynamic subtest vma: SUCCESS (0.459s) [218.419478] Starting dynamic subtest: coherency [219.326244] Dynamic subtest coherency: SUCCESS (0.948s) [219.399328] Starting dynamic subtest: gtt [229.314634] Dynamic subtest gtt: SUCCESS (10.064s) [229.321654] Starting dynamic subtest: gem [229.864212] Dynamic subtest gem: SUCCESS (0.549s) [229.871168] Starting dynamic subtest: evict [231.013365] Dynamic subtest evict: SUCCESS (1.149s) [231.020353] Starting dynamic subtest: hugepages [236.554416] Dynamic subtest hugepages: SUCCESS (5.541s) [236.561461] Starting dynamic subtest: gem_contexts [248.524366] Dynamic subtest gem_contexts: SUCCESS (11.970s) [248.531320] Starting dynamic subtest: client [249.035563] Dynamic subtest client: SUCCESS (0.511s) [249.042706] Starting dynamic subtest: gem_migrate [249.505645] Dynamic subtest gem_migrate: SUCCESS (0.470s) [249.512618] Starting dynamic subtest: reset [250.289531] Dynamic subtest reset: SUCCESS (0.783s) [250.296411] Starting dynamic subtest: memory_region [250.734155] Dynamic subtest memory_region: SUCCESS (0.444s) [250.740880] Starting dynamic subtest: hangcheck [274.308058] Dynamic subtest hangcheck: SUCCESS (23.517s) [274.372873] Starting dynamic subtest: execlists [282.289465] Dynamic subtest execlists: SUCCESS (8.038s) [282.296700] Starting dynamic subtest: ring_submission [282.738474] Dynamic subtest ring_submission: SUCCESS (0.449s) [282.745527] Starting dynamic subtest: perf [283.283350] Dynamic subtest perf: SUCCESS (0.545s) [283.290500] Starting dynamic subtest: slpc [283.740326] Dynamic subtest slpc: SUCCESS (0.457s) [283.747227] Starting dynamic subtest: guc [284.179403] Dynamic subtest guc: SUCCESS (0.439s) [284.186314] Starting dynamic subtest: guc_multi_lrc [284.637287] Dynamic subtest guc_multi_lrc: SUCCESS (0.458s) [284.644009] Starting dynamic subtest: guc_hang [285.098195] Dynamic subtest guc_hang: SUCCESS (0.461s) [285.105036] Starting dynamic subtest: late_gt_pm [285.575404] Dynamic subtest late_gt_pm: SUCCESS (0.477s) [285.578800] Subtest live: SUCCESS (98.429s) [285.637039] [165/171] (724s left) dmabuf (all-tests) [285.719124] Starting subtest: all-tests [285.722170] Starting dynamic subtest: sanitycheck [285.747142] Dynamic subtest sanitycheck: SUCCESS (0.032s) [285.754753] Starting dynamic subtest: dma_fence [285.874265] Dynamic subtest dma_fence: SUCCESS (0.127s) [285.881595] Starting dynamic subtest: dma_fence_chain [296.224398] Dynamic subtest dma_fence_chain: SUCCESS (10.350s) [296.231239] Starting dynamic subtest: dma_fence_unwrap [296.257315] Dynamic subtest dma_fence_unwrap: SUCCESS (0.033s) [296.265152] Starting dynamic subtest: dma_resv [296.287405] Dynamic subtest dma_resv: SUCCESS (0.030s) [296.290824] Subtest all-tests: SUCCESS (10.572s) [296.311790] [166/171] (713s left) i915_suspend (basic-s2idle-without-i915) [296.371501] Starting subtest: basic-s2idle-without-i915 [314.290425] Subtest basic-s2idle-without-i915: SUCCESS (2.072s) [319.451771] [167/171] (711s left) i915_suspend (basic-s3-without-i915) [319.512419] Starting subtest: basic-s3-without-i915 [337.468788] Subtest basic-s3-without-i915: SUCCESS (2.024s) [346.626448] [168/171] (708s left) gem_exec_suspend (basic-s0) [346.696568] Starting subtest: basic-S0 [346.699833] Starting dynamic subtest: smem [364.340768] Dynamic subtest smem: SUCCESS (1.718s) [364.343950] Subtest basic-S0: SUCCESS (1.719s) [368.494529] [169/171] (706s left) gem_exec_suspend (basic-s3) [368.558427] Starting subtest: basic-S3 [368.561800] Starting dynamic subtest: smem [386.472184] Dynamic subtest smem: SUCCESS (1.957s) [386.475299] Subtest basic-S3: SUCCESS (1.957s) [392.658410] [170/171] (704s left) kms_chamelium_hpd (common-hpd-after-suspend) [392.834763] Subtest common-hpd-after-suspend: SKIP (0.000s) [392.902438] [171/171] (704s left) kms_pipe_crc_basic (suspend-read-crc) [393.003323] Starting subtest: suspend-read-crc [393.006589] Starting dynamic subtest: pipe-A-HDMI-A-1 [411.600859] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.848s) [411.609792] Starting dynamic subtest: pipe-B-HDMI-A-1 [429.619304] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.806s) [429.627903] Starting dynamic subtest: pipe-C-HDMI-A-1 [447.611952] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.817s) [447.615539] Subtest suspend-read-crc: SUCCESS (5.474s) [455.684715] Closing watchdogs Done.