[41.651861] Initializing watchdogs [41.651922] /dev/watchdog0 [41.657284] [001/171] (960s left) i915_module_load (load) [41.707215] Starting subtest: load [42.571279] Subtest load: SUCCESS (0.864s) [42.585925] [002/171] (959s left) core_auth (basic-auth) [42.671884] Starting subtest: basic-auth [42.673631] Subtest basic-auth: SUCCESS (0.000s) [42.732416] [003/171] (959s left) debugfs_test (read_all_entries) [42.786116] Starting subtest: read_all_entries [42.838175] Subtest read_all_entries: SUCCESS (0.052s) [42.947991] [004/171] (959s left) debugfs_test (basic-hwmon) [42.997488] Starting subtest: basic-hwmon [43.000347] Subtest basic-hwmon: SKIP (0.000s) [43.098864] [005/171] (959s left) fbdev (eof) [43.154737] Starting subtest: eof [43.156321] Subtest eof: SUCCESS (0.000s) [43.198364] [006/171] (959s left) fbdev (info) [43.257914] Starting subtest: info [43.259661] Subtest info: SUCCESS (0.000s) [43.315600] [007/171] (958s left) fbdev (nullptr) [43.371197] Starting subtest: nullptr [43.372918] Subtest nullptr: SUCCESS (0.000s) [43.417319] [008/171] (958s left) fbdev (read) [43.471476] Starting subtest: read [43.692024] Subtest read: SUCCESS (0.221s) [43.731320] [009/171] (958s left) fbdev (write) [43.787992] Starting subtest: write [43.898664] Subtest write: SUCCESS (0.111s) [43.931330] [010/171] (958s left) gem_basic (bad-close) [43.980148] Starting subtest: bad-close [43.983323] Subtest bad-close: SUCCESS (0.000s) [44.031079] [011/171] (958s left) gem_basic (create-close) [44.086143] Starting subtest: create-close [44.089529] Subtest create-close: SUCCESS (0.000s) [44.150093] [012/171] (958s left) gem_basic (create-fd-close) [44.202481] Starting subtest: create-fd-close [44.205980] Subtest create-fd-close: SUCCESS (0.000s) [44.268316] [013/171] (958s left) gem_busy (busy@all-engines) [44.325972] Starting subtest: busy [44.327383] Starting dynamic subtest: all-engines [44.342836] Dynamic subtest all-engines: SUCCESS (0.017s) [44.344268] Subtest busy: SUCCESS (0.017s) [44.705650] [014/171] (957s left) gem_close_race (basic-process) [44.769620] Starting subtest: basic-process [44.812958] Subtest basic-process: SUCCESS (0.043s) [44.977636] [015/171] (957s left) gem_close_race (basic-threads) [45.041983] Starting subtest: basic-threads [46.243441] Subtest basic-threads: SUCCESS (1.201s) [46.453398] [016/171] (955s left) gem_ctx_create (basic) [46.523210] Starting subtest: basic [46.524749] Subtest basic: SUCCESS (0.000s) [46.701121] [017/171] (955s left) gem_ctx_create (basic-files) [46.753768] Starting subtest: basic-files [48.761020] Subtest basic-files: SUCCESS (2.007s) [49.003410] [018/171] (953s left) gem_ctx_exec (basic) [49.070206] Starting subtest: basic [49.071755] Subtest basic: SUCCESS (0.002s) [49.150617] [019/171] (953s left) gem_exec_basic (basic) [49.254519] Starting subtest: basic [49.256108] Starting dynamic subtest: rcs0-smem [49.257625] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [49.262314] Starting dynamic subtest: bcs0-smem [49.263906] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [49.276038] Starting dynamic subtest: vcs0-smem [49.277848] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [49.288669] Starting dynamic subtest: vecs0-smem [49.290619] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [49.292489] Subtest basic: SUCCESS (0.003s) [49.485411] [020/171] (952s left) gem_exec_create (basic) [49.552832] Starting subtest: basic [49.554432] Starting dynamic subtest: smem [51.593576] Dynamic subtest smem: SUCCESS (2.040s) [51.595190] Subtest basic: SUCCESS (2.040s) [51.750111] [021/171] (950s left) gem_exec_fence (basic-busy) [51.939638] Starting subtest: basic-busy [51.942198] Starting dynamic subtest: rcs0 [51.971752] Dynamic subtest rcs0: SUCCESS (0.033s) [51.976760] Starting dynamic subtest: bcs0 [51.998760] Dynamic subtest bcs0: SUCCESS (0.027s) [52.006562] Starting dynamic subtest: vcs0 [52.029672] Dynamic subtest vcs0: SUCCESS (0.030s) [52.052126] Starting dynamic subtest: vecs0 [52.059737] Dynamic subtest vecs0: SUCCESS (0.030s) [52.062280] Subtest basic-busy: SUCCESS (0.120s) [52.569538] [022/171] (949s left) gem_exec_fence (basic-wait) [52.731117] Starting subtest: basic-wait [52.732622] Starting dynamic subtest: rcs0 [52.758722] Dynamic subtest rcs0: SUCCESS (0.028s) [52.763688] Starting dynamic subtest: bcs0 [52.781678] Dynamic subtest bcs0: SUCCESS (0.023s) [52.786898] Starting dynamic subtest: vcs0 [52.811789] Dynamic subtest vcs0: SUCCESS (0.030s) [52.816875] Starting dynamic subtest: vecs0 [52.839937] Dynamic subtest vecs0: SUCCESS (0.028s) [52.841650] Subtest basic-wait: SUCCESS (0.109s) [53.338933] [023/171] (949s left) gem_exec_fence (basic-await) [53.523715] Starting subtest: basic-await [53.526329] Starting dynamic subtest: rcs0 [53.613325] Dynamic subtest rcs0: SUCCESS (0.090s) [53.619895] Starting dynamic subtest: bcs0 [53.681765] Dynamic subtest bcs0: SUCCESS (0.068s) [53.691019] Starting dynamic subtest: vcs0 [53.749598] Dynamic subtest vcs0: SUCCESS (0.068s) [53.754838] Starting dynamic subtest: vecs0 [53.812993] Dynamic subtest vecs0: SUCCESS (0.063s) [53.815151] Subtest basic-await: SUCCESS (0.290s) [54.303332] [024/171] (948s left) gem_exec_fence (nb-await) [54.489437] Starting subtest: nb-await [54.492041] Starting dynamic subtest: rcs0 [54.561968] Dynamic subtest rcs0: SUCCESS (0.072s) [54.572254] Starting dynamic subtest: bcs0 [54.622828] Dynamic subtest bcs0: SUCCESS (0.061s) [54.632685] Starting dynamic subtest: vcs0 [54.682597] Dynamic subtest vcs0: SUCCESS (0.060s) [54.688528] Starting dynamic subtest: vecs0 [54.740405] Dynamic subtest vecs0: SUCCESS (0.057s) [54.742980] Subtest nb-await: SUCCESS (0.251s) [55.270889] [025/171] (947s left) gem_exec_gttfill (basic) [55.338073] Starting subtest: basic [59.966831] Subtest basic: SUCCESS (4.629s) [60.132220] [026/171] (942s left) gem_exec_parallel (engines) [60.230756] Starting subtest: engines [60.232309] Starting dynamic subtest: basic [61.582604] Dynamic subtest basic: SUCCESS (1.352s) [61.588187] Starting dynamic subtest: contexts [63.974893] Dynamic subtest contexts: SUCCESS (2.392s) [63.980666] Starting dynamic subtest: fds [66.206052] Dynamic subtest fds: SUCCESS (2.231s) [66.211668] Starting dynamic subtest: userptr [67.864148] Dynamic subtest userptr: SUCCESS (1.658s) [67.865865] Subtest engines: SUCCESS (7.633s) [68.055659] [027/171] (934s left) gem_exec_store (basic) [68.137420] Starting subtest: basic [68.180890] Subtest basic: SUCCESS (0.044s) [68.362422] [028/171] (934s left) gem_flink_basic (bad-flink) [68.410148] Starting subtest: bad-flink [68.411750] Subtest bad-flink: SUCCESS (0.000s) [68.467955] [029/171] (934s left) gem_flink_basic (bad-open) [68.536197] Starting subtest: bad-open [68.537684] Subtest bad-open: SUCCESS (0.000s) [68.582192] [030/171] (934s left) gem_flink_basic (basic) [68.628388] Starting subtest: basic [68.630184] Subtest basic: SUCCESS (0.000s) [68.709379] [031/171] (933s left) gem_flink_basic (double-flink) [68.765293] Starting subtest: double-flink [68.766938] Subtest double-flink: SUCCESS (0.000s) [68.839337] [032/171] (933s left) gem_flink_basic (flink-lifetime) [68.893114] Starting subtest: flink-lifetime [68.894713] Subtest flink-lifetime: SUCCESS (0.001s) [68.986117] [033/171] (933s left) gem_huc_copy (huc-copy) [69.084627] Starting subtest: huc-copy [69.087891] Subtest huc-copy: SKIP (0.000s) [69.191932] [034/171] (933s left) gem_linear_blits (basic) [69.342623] Starting subtest: basic [69.348420] Subtest basic: SUCCESS (0.006s) [69.465385] [035/171] (933s left) gem_mmap (basic) [69.591795] Starting subtest: basic [69.599811] Subtest basic: SUCCESS (0.000s) [69.682569] [036/171] (933s left) gem_mmap_gtt (basic) [69.740785] Starting subtest: basic [69.742210] Subtest basic: SUCCESS (0.000s) [69.796415] [037/171] (933s left) gem_render_linear_blits (basic) [69.851510] Starting subtest: basic [69.879894] Subtest basic: SUCCESS (0.029s) [69.913128] [038/171] (932s left) gem_render_tiled_blits (basic) [69.964160] Starting subtest: basic [69.987941] Subtest basic: SUCCESS (0.024s) [70.030248] [039/171] (932s left) gem_ringfill (basic-all) [70.242706] Starting subtest: basic-all [71.359778] Subtest basic-all: SUCCESS (1.119s) [71.491163] [040/171] (931s left) gem_softpin (allocator-basic) [71.553399] Starting subtest: allocator-basic [71.609817] Subtest allocator-basic: SUCCESS (0.057s) [71.708844] [041/171] (931s left) gem_softpin (allocator-basic-reserve) [71.787140] Starting subtest: allocator-basic-reserve [71.845965] Subtest allocator-basic-reserve: SUCCESS (0.059s) [71.949371] [042/171] (930s left) gem_softpin (safe-alignment) [72.008243] Starting subtest: safe-alignment [72.017081] Subtest safe-alignment: SUCCESS (0.009s) [72.120271] [043/171] (930s left) gem_sync (basic-all) [72.193258] Starting subtest: basic-all [74.295092] Subtest basic-all: SUCCESS (2.109s) [74.451265] [044/171] (928s left) gem_sync (basic-each) [74.518131] Starting subtest: basic-each [76.556701] Subtest basic-each: SUCCESS (2.045s) [76.756465] [045/171] (926s left) gem_tiled_blits (basic) [76.923628] Starting subtest: basic [76.936033] Subtest basic: SUCCESS (0.013s) [77.081260] [046/171] (925s left) gem_tiled_fence_blits (basic) [77.229387] Starting subtest: basic [77.235329] Subtest basic: SUCCESS (0.006s) [77.357425] [047/171] (925s left) gem_tiled_pread_basic [77.640081] [048/171] (925s left) gem_wait (busy@all-engines) [77.703189] Starting subtest: busy [77.704598] Starting dynamic subtest: all-engines [78.217943] Dynamic subtest all-engines: SUCCESS (0.515s) [78.219760] Subtest busy: SUCCESS (0.515s) [78.390894] [049/171] (924s left) gem_wait (wait@all-engines) [78.450628] Starting subtest: wait [78.452088] Starting dynamic subtest: all-engines [79.484890] Dynamic subtest all-engines: SUCCESS (1.033s) [79.487835] Subtest wait: SUCCESS (1.033s) [79.668575] [050/171] (923s left) i915_getparams_basic (basic-eu-total) [79.720069] Starting subtest: basic-eu-total [79.722771] Subtest basic-eu-total: SUCCESS (0.000s) [79.790407] [051/171] (923s left) i915_getparams_basic (basic-subslice-total) [79.844420] Starting subtest: basic-subslice-total [79.847252] Subtest basic-subslice-total: SUCCESS (0.000s) [79.901561] [052/171] (923s left) i915_hangman (error-state-basic) [79.969382] Starting subtest: error-state-basic [79.973362] Subtest error-state-basic: SUCCESS (0.003s) [80.059287] [053/171] (923s left) i915_pciid [80.187271] [054/171] (923s left) kms_addfb_basic (addfb25-bad-modifier) [80.241392] Starting subtest: addfb25-bad-modifier [80.242844] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [80.365223] [055/171] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [80.413567] Starting subtest: addfb25-framebuffer-vs-set-tiling [80.414886] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [80.532943] [056/171] (922s left) kms_addfb_basic (addfb25-modifier-no-flag) [80.581860] Starting subtest: addfb25-modifier-no-flag [80.583281] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [80.698607] [057/171] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy) [80.748370] Starting subtest: addfb25-x-tiled-legacy [80.749909] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [80.866299] [058/171] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [80.914387] Starting subtest: addfb25-x-tiled-mismatch-legacy [80.915729] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [81.033321] [059/171] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [81.128274] Starting subtest: addfb25-yf-tiled-legacy [81.129545] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [81.200853] [060/171] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy) [81.297461] Starting subtest: addfb25-y-tiled-legacy [81.298886] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [81.365805] [061/171] (921s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [81.463177] Starting subtest: addfb25-y-tiled-small-legacy [81.464669] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [81.532780] [062/171] (921s left) kms_addfb_basic (bad-pitch-0) [81.580172] Starting subtest: bad-pitch-0 [81.581735] Subtest bad-pitch-0: SUCCESS (0.000s) [81.699041] [063/171] (921s left) kms_addfb_basic (bad-pitch-1024) [81.746177] Starting subtest: bad-pitch-1024 [81.747743] Subtest bad-pitch-1024: SUCCESS (0.000s) [81.882261] [064/171] (921s left) kms_addfb_basic (bad-pitch-128) [81.930066] Starting subtest: bad-pitch-128 [81.931516] Subtest bad-pitch-128: SUCCESS (0.000s) [82.065822] [065/171] (921s left) kms_addfb_basic (bad-pitch-256) [82.112923] Starting subtest: bad-pitch-256 [82.114360] Subtest bad-pitch-256: SUCCESS (0.000s) [82.232489] [066/171] (921s left) kms_addfb_basic (bad-pitch-32) [82.281192] Starting subtest: bad-pitch-32 [82.282708] Subtest bad-pitch-32: SUCCESS (0.000s) [82.399011] [067/171] (920s left) kms_addfb_basic (bad-pitch-63) [82.446070] Starting subtest: bad-pitch-63 [82.447481] Subtest bad-pitch-63: SUCCESS (0.000s) [82.565922] [068/171] (920s left) kms_addfb_basic (bad-pitch-65536) [82.614522] Starting subtest: bad-pitch-65536 [82.616052] Subtest bad-pitch-65536: SUCCESS (0.000s) [82.732303] [069/171] (920s left) kms_addfb_basic (bad-pitch-999) [82.779114] Starting subtest: bad-pitch-999 [82.780557] Subtest bad-pitch-999: SUCCESS (0.000s) [82.915585] [070/171] (920s left) kms_addfb_basic (basic) [82.969594] Starting subtest: basic [82.971422] Subtest basic: SUCCESS (0.000s) [83.098985] [071/171] (920s left) kms_addfb_basic (basic-x-tiled-legacy) [83.152395] Starting subtest: basic-x-tiled-legacy [83.153943] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [83.265886] [072/171] (920s left) kms_addfb_basic (basic-y-tiled-legacy) [83.314487] Starting subtest: basic-y-tiled-legacy [83.315929] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [83.432099] [073/171] (919s left) kms_addfb_basic (bo-too-small) [83.529102] Starting subtest: bo-too-small [83.530676] Subtest bo-too-small: SUCCESS (0.000s) [83.619866] [074/171] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling) [83.716087] Starting subtest: bo-too-small-due-to-tiling [83.717628] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [83.798937] [075/171] (919s left) kms_addfb_basic (clobberred-modifier) [83.852473] Starting subtest: clobberred-modifier [83.853890] Subtest clobberred-modifier: SUCCESS (0.000s) [83.982191] [076/171] (919s left) kms_addfb_basic (framebuffer-vs-set-tiling) [84.031028] Starting subtest: framebuffer-vs-set-tiling [84.032540] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.165462] [077/171] (919s left) kms_addfb_basic (invalid-get-prop) [84.212230] Starting subtest: invalid-get-prop [84.213847] Subtest invalid-get-prop: SUCCESS (0.000s) [84.332102] [078/171] (919s left) kms_addfb_basic (invalid-get-prop-any) [84.379679] Starting subtest: invalid-get-prop-any [84.381138] Subtest invalid-get-prop-any: SUCCESS (0.000s) [84.499068] [079/171] (918s left) kms_addfb_basic (invalid-set-prop) [84.546669] Starting subtest: invalid-set-prop [84.548104] Subtest invalid-set-prop: SUCCESS (0.000s) [84.665778] [080/171] (918s left) kms_addfb_basic (invalid-set-prop-any) [84.713058] Starting subtest: invalid-set-prop-any [84.714611] Subtest invalid-set-prop-any: SUCCESS (0.000s) [84.832191] [081/171] (918s left) kms_addfb_basic (no-handle) [84.879230] Starting subtest: no-handle [84.880789] Subtest no-handle: SUCCESS (0.000s) [84.999219] [082/171] (918s left) kms_addfb_basic (size-max) [85.096452] Starting subtest: size-max [85.098271] Subtest size-max: SUCCESS (0.000s) [85.165910] [083/171] (918s left) kms_addfb_basic (small-bo) [85.265693] Starting subtest: small-bo [85.267256] Subtest small-bo: SUCCESS (0.000s) [85.349203] [084/171] (918s left) kms_addfb_basic (tile-pitch-mismatch) [85.404257] Starting subtest: tile-pitch-mismatch [85.405803] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [85.532326] [085/171] (918s left) kms_addfb_basic (too-high) [85.627608] Starting subtest: too-high [85.629113] Subtest too-high: SUCCESS (0.000s) [85.698993] [086/171] (917s left) kms_addfb_basic (too-wide) [85.797148] Starting subtest: too-wide [85.798728] Subtest too-wide: SUCCESS (0.000s) [85.866236] [087/171] (917s left) kms_addfb_basic (unused-handle) [85.915498] Starting subtest: unused-handle [85.917092] Subtest unused-handle: SUCCESS (0.000s) [86.032082] [088/171] (917s left) kms_addfb_basic (unused-modifier) [86.079770] Starting subtest: unused-modifier [86.081358] Subtest unused-modifier: SUCCESS (0.000s) [86.199263] [089/171] (917s left) kms_addfb_basic (unused-offsets) [86.247304] Starting subtest: unused-offsets [86.248898] Subtest unused-offsets: SUCCESS (0.000s) [86.365732] [090/171] (917s left) kms_addfb_basic (unused-pitches) [86.414195] Starting subtest: unused-pitches [86.415634] Subtest unused-pitches: SUCCESS (0.000s) [86.532239] [091/171] (917s left) kms_busy (basic) [86.634571] Starting subtest: basic [86.635997] Starting dynamic subtest: flip [87.109861] Dynamic subtest flip: SUCCESS (0.473s) [87.117239] Starting dynamic subtest: modeset [87.452908] Dynamic subtest modeset: SUCCESS (0.345s) [87.454427] Subtest basic: SUCCESS (0.819s) [87.562772] [092/171] (916s left) kms_chamelium_hpd (dp-hpd-fast) [87.689036] Subtest dp-hpd-fast: SKIP (0.000s) [87.733156] [093/171] (915s left) kms_chamelium_edid (dp-edid-read) [87.846483] Subtest dp-edid-read: SKIP (0.000s) [87.891317] [094/171] (915s left) kms_chamelium_frames (dp-crc-fast) [88.006754] Subtest dp-crc-fast: SKIP (0.000s) [88.051261] [095/171] (915s left) kms_chamelium_hpd (hdmi-hpd-fast) [88.163586] Subtest hdmi-hpd-fast: SKIP (0.000s) [88.208474] [096/171] (915s left) kms_chamelium_edid (hdmi-edid-read) [88.321744] Subtest hdmi-edid-read: SKIP (0.000s) [88.367811] [097/171] (915s left) kms_chamelium_frames (hdmi-crc-fast) [88.478093] Subtest hdmi-crc-fast: SKIP (0.000s) [88.523575] [098/171] (915s left) kms_chamelium_hpd (vga-hpd-fast) [88.636218] Subtest vga-hpd-fast: SKIP (0.000s) [88.680505] [099/171] (915s left) kms_chamelium_edid (vga-edid-read) [88.792205] Subtest vga-edid-read: SKIP (0.000s) [88.836313] [100/171] (914s left) kms_prop_blob (basic) [88.885426] Starting subtest: basic [88.886889] Subtest basic: SUCCESS (0.000s) [88.937876] [101/171] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [89.036820] Starting subtest: basic-busy-flip-before-cursor-atomic [89.039432] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [89.087949] [102/171] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [89.184924] Starting subtest: basic-busy-flip-before-cursor-legacy [89.187618] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [89.238090] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [89.335276] Starting subtest: basic-flip-after-cursor-atomic [90.246980] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.910s) [90.343670] [104/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [90.441982] Starting subtest: basic-flip-after-cursor-legacy [91.352152] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.910s) [91.450457] [105/171] (912s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [91.548917] Starting subtest: basic-flip-after-cursor-varying-size [92.475852] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.927s) [92.580718] [106/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [92.676061] Starting subtest: basic-flip-before-cursor-atomic [93.588186] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.911s) [93.685747] [107/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [93.782053] Starting subtest: basic-flip-before-cursor-legacy [94.692715] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.909s) [94.791290] [108/171] (909s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [94.886429] Starting subtest: basic-flip-before-cursor-varying-size [95.799919] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.912s) [95.884136] [109/171] (907s left) kms_flip (basic-flip-vs-dpms) [95.968725] Starting subtest: basic-flip-vs-dpms [95.970130] Starting dynamic subtest: A-HDMI-A1 [96.798955] Dynamic subtest A-HDMI-A1: SUCCESS (0.828s) [96.804998] Starting dynamic subtest: B-HDMI-A1 [97.606584] Dynamic subtest B-HDMI-A1: SUCCESS (0.808s) [97.613771] Starting dynamic subtest: C-HDMI-A1 [98.416534] Dynamic subtest C-HDMI-A1: SUCCESS (0.809s) [98.418095] Subtest basic-flip-vs-dpms: SUCCESS (2.449s) [98.530990] [110/171] (905s left) kms_flip (basic-flip-vs-modeset) [98.619823] Starting subtest: basic-flip-vs-modeset [98.621394] Starting dynamic subtest: A-HDMI-A1 [99.407980] Dynamic subtest A-HDMI-A1: SUCCESS (0.785s) [99.414012] Starting dynamic subtest: B-HDMI-A1 [100.231440] Dynamic subtest B-HDMI-A1: SUCCESS (0.824s) [100.237587] Starting dynamic subtest: C-HDMI-A1 [101.056156] Dynamic subtest C-HDMI-A1: SUCCESS (0.824s) [101.057694] Subtest basic-flip-vs-modeset: SUCCESS (2.436s) [101.151115] [111/171] (902s left) kms_flip (basic-flip-vs-wf_vblank) [101.242378] Starting subtest: basic-flip-vs-wf_vblank [101.243866] Starting dynamic subtest: A-HDMI-A1 [102.343825] Dynamic subtest A-HDMI-A1: SUCCESS (1.103s) [102.349824] Starting dynamic subtest: B-HDMI-A1 [103.416128] Dynamic subtest B-HDMI-A1: SUCCESS (1.072s) [103.422157] Starting dynamic subtest: C-HDMI-A1 [104.486366] Dynamic subtest C-HDMI-A1: SUCCESS (1.070s) [104.487790] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.249s) [104.603767] [112/171] (899s left) kms_flip (basic-plain-flip) [104.688225] Starting subtest: basic-plain-flip [104.689652] Starting dynamic subtest: A-HDMI-A1 [105.497196] Dynamic subtest A-HDMI-A1: SUCCESS (0.808s) [105.503232] Starting dynamic subtest: B-HDMI-A1 [106.286092] Dynamic subtest B-HDMI-A1: SUCCESS (0.788s) [106.291978] Starting dynamic subtest: C-HDMI-A1 [107.075309] Dynamic subtest C-HDMI-A1: SUCCESS (0.788s) [107.079536] Subtest basic-plain-flip: SUCCESS (2.392s) [107.175335] [113/171] (896s left) kms_force_connector_basic (force-connector-state) [107.323300] Starting subtest: force-connector-state [107.665164] Subtest force-connector-state: SUCCESS (0.341s) [108.079764] [114/171] (895s left) kms_force_connector_basic (force-edid) [108.225029] Starting subtest: force-edid [108.362007] Subtest force-edid: SUCCESS (0.137s) [108.562669] [115/171] (895s left) kms_force_connector_basic (force-load-detect) [108.708090] Starting subtest: force-load-detect [108.710570] Subtest force-load-detect: SKIP (0.000s) [108.896726] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes) [109.043565] Starting subtest: prune-stale-modes [109.179781] Subtest prune-stale-modes: SUCCESS (0.135s) [109.380146] [117/171] (894s left) kms_frontbuffer_tracking (basic) [109.485989] Starting subtest: basic [111.900547] Subtest basic: SUCCESS (2.420s) [111.981341] [118/171] (891s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [112.083240] Starting subtest: compare-crc-sanitycheck [112.084555] Starting dynamic subtest: pipe-A-HDMI-A-1 [112.406370] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.322s) [112.412568] Starting dynamic subtest: pipe-B-HDMI-A-1 [112.741790] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.334s) [112.750347] Starting dynamic subtest: pipe-C-HDMI-A-1 [113.093501] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.350s) [113.094932] Subtest compare-crc-sanitycheck: SUCCESS (1.010s) [113.181902] [119/171] (890s left) kms_pipe_crc_basic (hang-read-crc) [113.281196] Starting subtest: hang-read-crc [113.282678] Starting dynamic subtest: pipe-A-HDMI-A-1 [114.110914] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.829s) [114.119139] Starting dynamic subtest: pipe-B-HDMI-A-1 [114.939799] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.827s) [114.946896] Starting dynamic subtest: pipe-C-HDMI-A-1 [115.830894] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.891s) [115.832464] Subtest hang-read-crc: SUCCESS (2.550s) [115.907716] [120/171] (888s left) kms_pipe_crc_basic (nonblocking-crc) [116.006359] Starting subtest: nonblocking-crc [116.007823] Starting dynamic subtest: pipe-A-HDMI-A-1 [116.500594] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.491s) [116.508224] Starting dynamic subtest: pipe-B-HDMI-A-1 [116.973867] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.473s) [116.981420] Starting dynamic subtest: pipe-C-HDMI-A-1 [117.484568] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.509s) [117.486144] Subtest nonblocking-crc: SUCCESS (1.476s) [117.560661] [121/171] (886s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [117.658312] Starting subtest: nonblocking-crc-frame-sequence [117.659699] Starting dynamic subtest: pipe-A-HDMI-A-1 [118.169682] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.509s) [118.178425] Starting dynamic subtest: pipe-B-HDMI-A-1 [118.646730] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.476s) [118.653855] Starting dynamic subtest: pipe-C-HDMI-A-1 [119.156430] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.509s) [119.157980] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.496s) [119.283386] [122/171] (884s left) kms_pipe_crc_basic (read-crc) [119.382550] Starting subtest: read-crc [119.384012] Starting dynamic subtest: pipe-A-HDMI-A-1 [119.807821] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.425s) [119.814454] Starting dynamic subtest: pipe-B-HDMI-A-1 [120.218785] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.408s) [120.225045] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.663583] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.444s) [120.665215] Subtest read-crc: SUCCESS (1.281s) [120.740539] [123/171] (883s left) kms_pipe_crc_basic (read-crc-frame-sequence) [120.839555] Starting subtest: read-crc-frame-sequence [120.841121] Starting dynamic subtest: pipe-A-HDMI-A-1 [121.264988] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.426s) [121.271558] Starting dynamic subtest: pipe-B-HDMI-A-1 [121.675876] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.408s) [121.682153] Starting dynamic subtest: pipe-C-HDMI-A-1 [122.128414] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.443s) [122.130225] Subtest read-crc-frame-sequence: SUCCESS (1.280s) [122.195356] [124/171] (881s left) kms_psr (primary_page_flip) [122.245624] Subtest primary_page_flip: SKIP (0.000s) [122.273327] [125/171] (881s left) kms_psr (cursor_plane_move) [122.322051] Subtest cursor_plane_move: SKIP (0.000s) [122.340401] [126/171] (881s left) kms_psr (sprite_plane_onoff) [122.391430] Subtest sprite_plane_onoff: SKIP (0.000s) [122.406582] [127/171] (881s left) kms_psr (primary_mmap_gtt) [122.455506] Subtest primary_mmap_gtt: SKIP (0.000s) [122.474173] [128/171] (881s left) kms_setmode (basic-clone-single-crtc) [122.524103] Starting subtest: basic-clone-single-crtc [122.529063] Subtest basic-clone-single-crtc: SKIP (0.000s) [122.580589] [129/171] (881s left) i915_pm_backlight (basic-brightness) [122.703783] Subtest basic-brightness: SKIP (0.000s) [122.724813] [130/171] (881s left) i915_pm_rpm (basic-pci-d3-state) [124.110076] Starting subtest: basic-pci-d3-state [124.550259] Subtest basic-pci-d3-state: SUCCESS (0.440s) [124.832731] [131/171] (879s left) i915_pm_rpm (basic-rte) [124.881380] Starting subtest: basic-rte [126.642524] Subtest basic-rte: SUCCESS (1.763s) [127.347754] [132/171] (876s left) i915_pm_rps (basic-api) [127.398725] Starting subtest: basic-api [127.401986] Subtest basic-api: SUCCESS (0.002s) [127.468894] [133/171] (876s left) prime_self_import (basic-llseek-bad) [127.545055] Starting subtest: basic-llseek-bad [127.546570] Subtest basic-llseek-bad: SUCCESS (0.001s) [127.620139] [134/171] (876s left) prime_self_import (basic-llseek-size) [127.695862] Starting subtest: basic-llseek-size [127.697193] Subtest basic-llseek-size: SUCCESS (0.002s) [127.769784] [135/171] (876s left) prime_self_import (basic-with_fd_dup) [127.846330] Starting subtest: basic-with_fd_dup [127.848155] Subtest basic-with_fd_dup: SUCCESS (0.001s) [127.920270] [136/171] (876s left) prime_self_import (basic-with_one_bo) [127.996830] Starting subtest: basic-with_one_bo [127.998433] Subtest basic-with_one_bo: SUCCESS (0.002s) [128.042984] [137/171] (876s left) prime_self_import (basic-with_one_bo_two_files) [128.096949] Starting subtest: basic-with_one_bo_two_files [128.098654] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [128.201347] [138/171] (876s left) prime_self_import (basic-with_two_bos) [128.295196] Starting subtest: basic-with_two_bos [128.296803] Subtest basic-with_two_bos: SUCCESS (0.002s) [128.390082] [139/171] (875s left) prime_vgem (basic-fence-flip) [128.471295] Starting subtest: basic-fence-flip [128.868366] Subtest basic-fence-flip: SUCCESS (0.397s) [128.950423] [140/171] (875s left) prime_vgem (basic-fence-mmap) [129.021376] Starting subtest: basic-fence-mmap [129.035048] Subtest basic-fence-mmap: SUCCESS (0.014s) [129.144784] [141/171] (875s left) prime_vgem (basic-fence-read) [129.238333] Starting subtest: basic-fence-read [129.260805] Subtest basic-fence-read: SUCCESS (0.022s) [129.385416] [142/171] (875s left) prime_vgem (basic-gtt) [129.487846] Starting subtest: basic-gtt [129.494563] Subtest basic-gtt: SUCCESS (0.007s) [129.574649] [143/171] (874s left) prime_vgem (basic-read) [129.681376] Starting subtest: basic-read [129.691953] Subtest basic-read: SUCCESS (0.011s) [129.797668] [144/171] (874s left) prime_vgem (basic-write) [129.862858] Starting subtest: basic-write [129.875041] Subtest basic-write: SUCCESS (0.012s) [129.958893] [145/171] (874s left) prime_vgem (basic-userptr) [130.064478] Starting subtest: basic-userptr [130.070156] Subtest basic-userptr: SKIP (0.004s) [130.189948] [146/171] (874s left) vgem_basic (setversion) [130.286517] Starting subtest: setversion [130.290424] Subtest setversion: SUCCESS (0.000s) [130.341628] [147/171] (874s left) vgem_basic (create) [130.418122] Starting subtest: create [130.419724] Subtest create: SUCCESS (0.000s) [130.463312] [148/171] (874s left) vgem_basic (debugfs) [130.518369] Starting subtest: debugfs [130.520009] Subtest debugfs: SUCCESS (0.000s) [130.571333] [149/171] (873s left) vgem_basic (dmabuf-export) [130.651711] Starting subtest: dmabuf-export [130.653247] Subtest dmabuf-export: SUCCESS (0.001s) [130.732950] [150/171] (873s left) vgem_basic (dmabuf-fence) [130.801835] Starting subtest: dmabuf-fence [130.803644] Subtest dmabuf-fence: SUCCESS (0.000s) [130.850798] [151/171] (873s left) vgem_basic (dmabuf-fence-before) [130.918475] Starting subtest: dmabuf-fence-before [130.920229] Subtest dmabuf-fence-before: SUCCESS (0.000s) [130.970307] [152/171] (873s left) vgem_basic (dmabuf-mmap) [131.034998] Starting subtest: dmabuf-mmap [131.043703] Subtest dmabuf-mmap: SUCCESS (0.008s) [131.079747] [153/171] (873s left) vgem_basic (mmap) [131.137233] Starting subtest: mmap [131.140792] Subtest mmap: SUCCESS (0.006s) [131.179920] [154/171] (873s left) vgem_basic (second-client) [131.234963] Starting subtest: second-client [131.284836] Subtest second-client: SUCCESS (0.050s) [131.374969] [155/171] (873s left) vgem_basic (sysfs) [131.468422] Starting subtest: sysfs [131.470038] Subtest sysfs: SUCCESS (0.000s) [131.516590] [156/171] (873s left) core_hotunplug (unbind-rebind) [131.618630] Starting subtest: unbind-rebind [132.449328] Subtest unbind-rebind: SUCCESS (0.831s) [132.463249] [157/171] (872s left) vgem_basic (unload) [132.514915] Starting subtest: unload [161.213708] Subtest unload: SUCCESS (28.699s) [161.280517] [158/171] (843s left) i915_module_load (reload) [161.334874] Starting subtest: reload [162.733562] Subtest reload: SUCCESS (1.399s) [162.752887] [159/171] (841s left) gem_lmem_swapping (basic) [162.822801] Subtest basic: SKIP (0.000s) [162.841507] [160/171] (841s left) gem_lmem_swapping (parallel-random-engines) [162.893636] Subtest parallel-random-engines: SKIP (0.000s) [162.909185] [161/171] (841s left) gem_lmem_swapping (random-engines) [162.960458] Subtest random-engines: SKIP (0.000s) [162.973546] [162/171] (841s left) gem_lmem_swapping (verify-random) [163.024275] Subtest verify-random: SKIP (0.000s) [163.040545] [163/171] (841s left) i915_pm_rpm (module-reload) [164.702539] Starting subtest: module-reload [171.673970] Subtest module-reload: SUCCESS (6.973s) [171.684468] [164/171] (833s left) i915_selftest (live) [171.743026] Starting subtest: live [171.744633] Starting dynamic subtest: sanitycheck [172.165202] Dynamic subtest sanitycheck: SUCCESS (0.421s) [172.175980] Starting dynamic subtest: uncore [172.596978] Dynamic subtest uncore: SUCCESS (0.431s) [172.602251] Starting dynamic subtest: workarounds [173.205963] Dynamic subtest workarounds: SUCCESS (0.608s) [173.211179] Starting dynamic subtest: gt_engines [174.118219] Dynamic subtest gt_engines: SUCCESS (0.912s) [174.123488] Starting dynamic subtest: gt_timelines [179.718073] Dynamic subtest gt_timelines: SUCCESS (5.600s) [179.723031] Starting dynamic subtest: gt_contexts [180.208814] Dynamic subtest gt_contexts: SUCCESS (0.491s) [180.215138] Starting dynamic subtest: gt_lrc [182.926678] Dynamic subtest gt_lrc: SUCCESS (2.718s) [182.931756] Starting dynamic subtest: gt_mocs [183.411704] Dynamic subtest gt_mocs: SUCCESS (0.485s) [183.416679] Starting dynamic subtest: gt_pm [185.707243] Dynamic subtest gt_pm: SUCCESS (2.295s) [185.712612] Starting dynamic subtest: gt_heartbeat [186.210720] Dynamic subtest gt_heartbeat: SUCCESS (0.503s) [186.215909] Starting dynamic subtest: requests [192.921110] Dynamic subtest requests: SUCCESS (6.710s) [192.925989] Starting dynamic subtest: migrate [196.205860] Dynamic subtest migrate: SUCCESS (3.284s) [196.210708] Starting dynamic subtest: active [196.639185] Dynamic subtest active: SUCCESS (0.432s) [196.644668] Starting dynamic subtest: objects [197.638871] Dynamic subtest objects: SUCCESS (1.000s) [197.643843] Starting dynamic subtest: mman [201.371969] Dynamic subtest mman: SUCCESS (3.733s) [201.378615] Starting dynamic subtest: dmabuf [201.833953] Dynamic subtest dmabuf: SUCCESS (0.461s) [201.839060] Starting dynamic subtest: vma [202.300961] Dynamic subtest vma: SUCCESS (0.467s) [202.305913] Starting dynamic subtest: coherency [203.311041] Dynamic subtest coherency: SUCCESS (1.009s) [203.316132] Starting dynamic subtest: gtt [213.087953] Dynamic subtest gtt: SUCCESS (9.776s) [213.093160] Starting dynamic subtest: gem [213.547042] Dynamic subtest gem: SUCCESS (0.459s) [213.552211] Starting dynamic subtest: evict [214.739864] Dynamic subtest evict: SUCCESS (1.192s) [214.744935] Starting dynamic subtest: hugepages [220.296026] Dynamic subtest hugepages: SUCCESS (5.556s) [220.301066] Starting dynamic subtest: gem_contexts [232.187954] Dynamic subtest gem_contexts: SUCCESS (11.892s) [232.193205] Starting dynamic subtest: client [232.638919] Dynamic subtest client: SUCCESS (0.451s) [232.644046] Starting dynamic subtest: gem_migrate [233.064991] Dynamic subtest gem_migrate: SUCCESS (0.426s) [233.070390] Starting dynamic subtest: reset [233.817046] Dynamic subtest reset: SUCCESS (0.752s) [233.822124] Starting dynamic subtest: memory_region [234.211865] Dynamic subtest memory_region: SUCCESS (0.394s) [234.217160] Starting dynamic subtest: hangcheck [257.642032] Dynamic subtest hangcheck: SUCCESS (23.430s) [257.647321] Starting dynamic subtest: execlists [265.666889] Dynamic subtest execlists: SUCCESS (8.025s) [265.672061] Starting dynamic subtest: ring_submission [266.072823] Dynamic subtest ring_submission: SUCCESS (0.406s) [266.079622] Starting dynamic subtest: perf [266.582992] Dynamic subtest perf: SUCCESS (0.510s) [266.588282] Starting dynamic subtest: slpc [266.991904] Dynamic subtest slpc: SUCCESS (0.409s) [266.997148] Starting dynamic subtest: guc [267.392029] Dynamic subtest guc: SUCCESS (0.400s) [267.397645] Starting dynamic subtest: guc_multi_lrc [267.844925] Dynamic subtest guc_multi_lrc: SUCCESS (0.453s) [267.850125] Starting dynamic subtest: guc_hang [268.242151] Dynamic subtest guc_hang: SUCCESS (0.397s) [268.247276] Starting dynamic subtest: late_gt_pm [268.686951] Dynamic subtest late_gt_pm: SUCCESS (0.445s) [268.688935] Subtest live: SUCCESS (96.944s) [268.750182] [165/171] (736s left) dmabuf (all-tests) [268.804222] Starting subtest: all-tests [268.806637] Starting dynamic subtest: sanitycheck [268.829945] Dynamic subtest sanitycheck: SUCCESS (0.026s) [268.835194] Starting dynamic subtest: dma_fence [268.959915] Dynamic subtest dma_fence: SUCCESS (0.130s) [268.965133] Starting dynamic subtest: dma_fence_chain [279.399904] Dynamic subtest dma_fence_chain: SUCCESS (10.440s) [279.405220] Starting dynamic subtest: dma_fence_unwrap [279.421863] Dynamic subtest dma_fence_unwrap: SUCCESS (0.022s) [279.427931] Starting dynamic subtest: dma_resv [279.443878] Dynamic subtest dma_resv: SUCCESS (0.022s) [279.445474] Subtest all-tests: SUCCESS (10.640s) [279.457642] [166/171] (725s left) i915_suspend (basic-s2idle-without-i915) [279.511692] Starting subtest: basic-s2idle-without-i915 [296.363429] Subtest basic-s2idle-without-i915: SUCCESS (1.661s) [301.494200] [167/171] (723s left) i915_suspend (basic-s3-without-i915) [301.545798] Starting subtest: basic-s3-without-i915 [319.425344] Subtest basic-s3-without-i915: SUCCESS (1.533s) [325.557444] [168/171] (721s left) gem_exec_suspend (basic-s0) [325.615860] Starting subtest: basic-S0 [325.617529] Starting dynamic subtest: smem [342.394671] Dynamic subtest smem: SUCCESS (1.616s) [342.396545] Subtest basic-S0: SUCCESS (1.617s) [347.987260] [169/171] (720s left) gem_exec_suspend (basic-s3) [348.044413] Starting subtest: basic-S3 [348.046351] Starting dynamic subtest: smem [366.456917] Dynamic subtest smem: SUCCESS (1.839s) [366.458811] Subtest basic-S3: SUCCESS (1.839s) [372.648167] [170/171] (718s left) kms_chamelium_hpd (common-hpd-after-suspend) [372.773775] Subtest common-hpd-after-suspend: SKIP (0.000s) [372.819650] [171/171] (717s left) kms_pipe_crc_basic (suspend-read-crc) [372.918611] Starting subtest: suspend-read-crc [372.920299] Starting dynamic subtest: pipe-A-HDMI-A-1 [390.526049] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.594s) [390.534385] Starting dynamic subtest: pipe-B-HDMI-A-1 [408.556321] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.607s) [408.564797] Starting dynamic subtest: pipe-C-HDMI-A-1 [426.543010] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.677s) [426.544795] Subtest suspend-read-crc: SUCCESS (4.881s) [431.592215] Closing watchdogs Done.