[40.055264] Initializing watchdogs [40.055395] /dev/watchdog0 [40.062833] [001/171] (960s left) i915_module_load (load) [40.167685] Starting subtest: load [41.222970] Subtest load: SUCCESS (1.055s) [41.256650] [002/171] (959s left) core_auth (basic-auth) [41.398099] Starting subtest: basic-auth [41.401585] Subtest basic-auth: SUCCESS (0.001s) [41.485012] [003/171] (959s left) debugfs_test (read_all_entries) [41.639224] Starting subtest: read_all_entries [41.703308] Subtest read_all_entries: SUCCESS (0.064s) [41.805528] [004/171] (958s left) debugfs_test (basic-hwmon) [41.907120] Starting subtest: basic-hwmon [41.909032] Subtest basic-hwmon: SKIP (0.000s) [42.029965] [005/171] (958s left) fbdev (eof) [42.132524] Starting subtest: eof [42.133576] Subtest eof: SUCCESS (0.001s) [42.189837] [006/171] (958s left) fbdev (info) [42.288251] Starting subtest: info [42.289359] Subtest info: SUCCESS (0.000s) [42.354840] [007/171] (958s left) fbdev (nullptr) [42.465462] Starting subtest: nullptr [42.466452] Subtest nullptr: SUCCESS (0.000s) [42.522257] [008/171] (958s left) fbdev (read) [42.632529] Starting subtest: read [43.489872] Subtest read: SUCCESS (0.849s) [43.539811] [009/171] (957s left) fbdev (write) [43.688359] Starting subtest: write [44.132568] Subtest write: SUCCESS (0.435s) [44.181349] [010/171] (956s left) gem_basic (bad-close) [44.278902] Starting subtest: bad-close [44.280940] Subtest bad-close: SUCCESS (0.000s) [44.350396] [011/171] (956s left) gem_basic (create-close) [44.449023] Starting subtest: create-close [44.450927] Subtest create-close: SUCCESS (0.000s) [44.580106] [012/171] (956s left) gem_basic (create-fd-close) [44.686345] Starting subtest: create-fd-close [44.688327] Subtest create-fd-close: SUCCESS (0.000s) [44.790302] [013/171] (956s left) gem_busy (busy@all-engines) [44.909533] Starting subtest: busy [44.910673] Starting dynamic subtest: all-engines [44.963968] Dynamic subtest all-engines: SUCCESS (0.054s) [44.964906] Subtest busy: SUCCESS (0.055s) [45.388770] [014/171] (955s left) gem_close_race (basic-process) [45.509035] Starting subtest: basic-process [45.579755] Subtest basic-process: SUCCESS (0.071s) [45.788933] [015/171] (955s left) gem_close_race (basic-threads) [45.907205] Starting subtest: basic-threads [47.072572] Subtest basic-threads: SUCCESS (1.165s) [47.347412] [016/171] (953s left) gem_ctx_create (basic) [47.472568] Starting subtest: basic [47.473735] Subtest basic: SUCCESS (0.000s) [47.689429] [017/171] (953s left) gem_ctx_create (basic-files) [47.807849] Starting subtest: basic-files [49.827654] Subtest basic-files: SUCCESS (2.020s) [50.116938] [018/171] (950s left) gem_ctx_exec (basic) [50.233973] Starting subtest: basic [50.240062] Subtest basic: SUCCESS (0.005s) [50.352555] [019/171] (950s left) gem_exec_basic (basic) [50.475048] Starting subtest: basic [50.476068] Starting dynamic subtest: rcs0-smem [50.478141] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [50.485704] Starting dynamic subtest: bcs0-smem [50.486589] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [50.493297] Starting dynamic subtest: vcs0-smem [50.494164] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [50.501194] Starting dynamic subtest: vecs0-smem [50.502457] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [50.503595] Subtest basic: SUCCESS (0.007s) [50.723369] [020/171] (950s left) gem_exec_create (basic) [50.840399] Starting subtest: basic [50.841328] Starting dynamic subtest: smem [52.879433] Dynamic subtest smem: SUCCESS (2.039s) [52.880425] Subtest basic: SUCCESS (2.039s) [53.104365] [021/171] (947s left) gem_exec_fence (basic-busy) [53.364800] Starting subtest: basic-busy [53.366641] Starting dynamic subtest: rcs0 [53.397192] Dynamic subtest rcs0: SUCCESS (0.033s) [53.404991] Starting dynamic subtest: bcs0 [53.423324] Dynamic subtest bcs0: SUCCESS (0.026s) [53.430888] Starting dynamic subtest: vcs0 [53.445345] Dynamic subtest vcs0: SUCCESS (0.022s) [53.452822] Starting dynamic subtest: vecs0 [53.468432] Dynamic subtest vecs0: SUCCESS (0.023s) [53.469561] Subtest basic-busy: SUCCESS (0.104s) [54.166230] [022/171] (946s left) gem_exec_fence (basic-wait) [54.425735] Starting subtest: basic-wait [54.426868] Starting dynamic subtest: rcs0 [54.452306] Dynamic subtest rcs0: SUCCESS (0.026s) [54.460065] Starting dynamic subtest: bcs0 [54.479300] Dynamic subtest bcs0: SUCCESS (0.027s) [54.487707] Starting dynamic subtest: vcs0 [54.503322] Dynamic subtest vcs0: SUCCESS (0.024s) [54.511171] Starting dynamic subtest: vecs0 [54.530385] Dynamic subtest vecs0: SUCCESS (0.027s) [54.531444] Subtest basic-wait: SUCCESS (0.105s) [55.219074] [023/171] (945s left) gem_exec_fence (basic-await) [55.491691] Starting subtest: basic-await [55.492889] Starting dynamic subtest: rcs0 [55.590263] Dynamic subtest rcs0: SUCCESS (0.099s) [55.599713] Starting dynamic subtest: bcs0 [55.685832] Dynamic subtest bcs0: SUCCESS (0.095s) [55.694508] Starting dynamic subtest: vcs0 [55.785974] Dynamic subtest vcs0: SUCCESS (0.100s) [55.796060] Starting dynamic subtest: vecs0 [55.892164] Dynamic subtest vecs0: SUCCESS (0.106s) [55.893228] Subtest basic-await: SUCCESS (0.401s) [56.641377] [024/171] (944s left) gem_exec_fence (nb-await) [56.921439] Starting subtest: nb-await [56.923092] Starting dynamic subtest: rcs0 [56.995326] Dynamic subtest rcs0: SUCCESS (0.072s) [57.026111] Starting dynamic subtest: bcs0 [57.088898] Dynamic subtest bcs0: SUCCESS (0.090s) [57.136419] Starting dynamic subtest: vcs0 [57.196788] Dynamic subtest vcs0: SUCCESS (0.110s) [57.243419] Starting dynamic subtest: vecs0 [57.309988] Dynamic subtest vecs0: SUCCESS (0.110s) [57.314710] Subtest nb-await: SUCCESS (0.386s) [58.062362] [025/171] (943s left) gem_exec_gttfill (basic) [58.182536] Starting subtest: basic [67.421396] Subtest basic: SUCCESS (9.230s) [67.608256] [026/171] (933s left) gem_exec_parallel (engines) [67.794593] Starting subtest: engines [67.795698] Starting dynamic subtest: basic [70.176445] Dynamic subtest basic: SUCCESS (2.382s) [70.185487] Starting dynamic subtest: contexts [73.219669] Dynamic subtest contexts: SUCCESS (3.034s) [73.228443] Starting dynamic subtest: fds [76.473573] Dynamic subtest fds: SUCCESS (3.263s) [76.482894] Starting dynamic subtest: userptr [78.867442] Dynamic subtest userptr: SUCCESS (2.394s) [78.868481] Subtest engines: SUCCESS (11.073s) [79.101337] [027/171] (922s left) gem_exec_store (basic) [79.227513] Starting subtest: basic [79.276437] Subtest basic: SUCCESS (0.049s) [79.495946] [028/171] (921s left) gem_flink_basic (bad-flink) [79.603198] Starting subtest: bad-flink [79.604235] Subtest bad-flink: SUCCESS (0.000s) [79.702238] [029/171] (921s left) gem_flink_basic (bad-open) [79.808497] Starting subtest: bad-open [79.809616] Subtest bad-open: SUCCESS (0.000s) [79.908880] [030/171] (921s left) gem_flink_basic (basic) [80.016398] Starting subtest: basic [80.017434] Subtest basic: SUCCESS (0.000s) [80.118615] [031/171] (921s left) gem_flink_basic (double-flink) [80.225348] Starting subtest: double-flink [80.226486] Subtest double-flink: SUCCESS (0.000s) [80.325226] [032/171] (920s left) gem_flink_basic (flink-lifetime) [80.434335] Starting subtest: flink-lifetime [80.435441] Subtest flink-lifetime: SUCCESS (0.001s) [80.539900] [033/171] (920s left) gem_huc_copy (huc-copy) [80.652445] Starting subtest: huc-copy [80.654425] Subtest huc-copy: SKIP (0.000s) [80.787897] [034/171] (920s left) gem_linear_blits (basic) [81.024799] Starting subtest: basic [81.034153] Subtest basic: SUCCESS (0.009s) [81.206383] [035/171] (920s left) gem_mmap (basic) [81.363336] Starting subtest: basic [81.368356] Subtest basic: SUCCESS (0.000s) [81.447958] [036/171] (919s left) gem_mmap_gtt (basic) [81.555441] Starting subtest: basic [81.556392] Subtest basic: SUCCESS (0.001s) [81.647969] [037/171] (919s left) gem_render_linear_blits (basic) [81.760430] Starting subtest: basic [81.801373] Subtest basic: SUCCESS (0.041s) [81.847122] [038/171] (919s left) gem_render_tiled_blits (basic) [81.963152] Starting subtest: basic [82.010523] Subtest basic: SUCCESS (0.047s) [82.047548] [039/171] (919s left) gem_ringfill (basic-all) [82.335120] Starting subtest: basic-all [83.500607] Subtest basic-all: SUCCESS (1.157s) [83.629920] [040/171] (917s left) gem_softpin (allocator-basic) [83.746225] Starting subtest: allocator-basic [83.885677] Subtest allocator-basic: SUCCESS (0.131s) [84.009499] [041/171] (917s left) gem_softpin (allocator-basic-reserve) [84.121615] Starting subtest: allocator-basic-reserve [84.271973] Subtest allocator-basic-reserve: SUCCESS (0.140s) [84.407395] [042/171] (917s left) gem_softpin (safe-alignment) [84.532433] Starting subtest: safe-alignment [84.547544] Subtest safe-alignment: SUCCESS (0.015s) [84.685996] [043/171] (916s left) gem_sync (basic-all) [84.811383] Starting subtest: basic-all [87.067420] Subtest basic-all: SUCCESS (2.256s) [87.297275] [044/171] (914s left) gem_sync (basic-each) [87.419691] Starting subtest: basic-each [89.683520] Subtest basic-each: SUCCESS (2.264s) [89.944631] [045/171] (911s left) gem_tiled_blits (basic) [90.199208] Starting subtest: basic [90.223975] Subtest basic: SUCCESS (0.025s) [90.388773] [046/171] (911s left) gem_tiled_fence_blits (basic) [90.692396] Starting subtest: basic [90.707969] Subtest basic: SUCCESS (0.014s) [90.865953] [047/171] (910s left) gem_tiled_pread_basic [91.249948] [048/171] (910s left) gem_wait (busy@all-engines) [91.379437] Starting subtest: busy [91.380592] Starting dynamic subtest: all-engines [91.914420] Dynamic subtest all-engines: SUCCESS (0.535s) [91.915353] Subtest busy: SUCCESS (0.535s) [92.167653] [049/171] (909s left) gem_wait (wait@all-engines) [92.298102] Starting subtest: wait [92.299190] Starting dynamic subtest: all-engines [93.357284] Dynamic subtest all-engines: SUCCESS (1.059s) [93.358346] Subtest wait: SUCCESS (1.060s) [93.601459] [050/171] (908s left) i915_getparams_basic (basic-eu-total) [93.708411] Starting subtest: basic-eu-total [93.710495] Subtest basic-eu-total: SUCCESS (0.000s) [93.801440] [051/171] (907s left) i915_getparams_basic (basic-subslice-total) [93.908207] Starting subtest: basic-subslice-total [93.909984] Subtest basic-subslice-total: SUCCESS (0.000s) [94.010075] [052/171] (907s left) i915_hangman (error-state-basic) [94.133076] Starting subtest: error-state-basic [94.146114] Subtest error-state-basic: SUCCESS (0.012s) [94.243599] [053/171] (907s left) i915_pciid [94.442029] [054/171] (907s left) kms_addfb_basic (addfb25-bad-modifier) [94.552082] Starting subtest: addfb25-bad-modifier [94.553125] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [94.717961] [055/171] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [94.824211] Starting subtest: addfb25-framebuffer-vs-set-tiling [94.825154] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [94.968834] [056/171] (906s left) kms_addfb_basic (addfb25-modifier-no-flag) [95.073239] Starting subtest: addfb25-modifier-no-flag [95.074312] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [95.204361] [057/171] (906s left) kms_addfb_basic (addfb25-x-tiled-legacy) [95.309341] Starting subtest: addfb25-x-tiled-legacy [95.310437] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [95.454168] [058/171] (906s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [95.558766] Starting subtest: addfb25-x-tiled-mismatch-legacy [95.560087] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [95.698789] [059/171] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [95.841091] Starting subtest: addfb25-yf-tiled-legacy [95.842142] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [95.936136] [060/171] (905s left) kms_addfb_basic (addfb25-y-tiled-legacy) [96.070210] Starting subtest: addfb25-y-tiled-legacy [96.071211] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [96.174249] [061/171] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [96.315392] Starting subtest: addfb25-y-tiled-small-legacy [96.316357] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [96.415237] [062/171] (905s left) kms_addfb_basic (bad-pitch-0) [96.513406] Starting subtest: bad-pitch-0 [96.514328] Subtest bad-pitch-0: SUCCESS (0.000s) [96.652182] [063/171] (905s left) kms_addfb_basic (bad-pitch-1024) [96.749072] Starting subtest: bad-pitch-1024 [96.750018] Subtest bad-pitch-1024: SUCCESS (0.000s) [96.889206] [064/171] (905s left) kms_addfb_basic (bad-pitch-128) [96.992293] Starting subtest: bad-pitch-128 [96.993203] Subtest bad-pitch-128: SUCCESS (0.000s) [97.137781] [065/171] (904s left) kms_addfb_basic (bad-pitch-256) [97.233589] Starting subtest: bad-pitch-256 [97.234528] Subtest bad-pitch-256: SUCCESS (0.000s) [97.370170] [066/171] (904s left) kms_addfb_basic (bad-pitch-32) [97.467388] Starting subtest: bad-pitch-32 [97.468355] Subtest bad-pitch-32: SUCCESS (0.000s) [97.603653] [067/171] (904s left) kms_addfb_basic (bad-pitch-63) [97.702325] Starting subtest: bad-pitch-63 [97.703384] Subtest bad-pitch-63: SUCCESS (0.000s) [97.836695] [068/171] (904s left) kms_addfb_basic (bad-pitch-65536) [97.933507] Starting subtest: bad-pitch-65536 [97.934502] Subtest bad-pitch-65536: SUCCESS (0.000s) [98.060123] [069/171] (903s left) kms_addfb_basic (bad-pitch-999) [98.156406] Starting subtest: bad-pitch-999 [98.157471] Subtest bad-pitch-999: SUCCESS (0.000s) [98.297454] [070/171] (903s left) kms_addfb_basic (basic) [98.393293] Starting subtest: basic [98.394305] Subtest basic: SUCCESS (0.000s) [98.526334] [071/171] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [98.621304] Starting subtest: basic-x-tiled-legacy [98.622360] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [98.756619] [072/171] (903s left) kms_addfb_basic (basic-y-tiled-legacy) [98.852431] Starting subtest: basic-y-tiled-legacy [98.853396] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [99.004141] [073/171] (903s left) kms_addfb_basic (bo-too-small) [99.140292] Starting subtest: bo-too-small [99.141282] Subtest bo-too-small: SUCCESS (0.000s) [99.244160] [074/171] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [99.382351] Starting subtest: bo-too-small-due-to-tiling [99.383449] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [99.483306] [075/171] (902s left) kms_addfb_basic (clobberred-modifier) [99.581438] Starting subtest: clobberred-modifier [99.582433] Subtest clobberred-modifier: SUCCESS (0.000s) [99.725579] [076/171] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling) [99.826201] Starting subtest: framebuffer-vs-set-tiling [99.827127] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [99.965881] [077/171] (902s left) kms_addfb_basic (invalid-get-prop) [100.063653] Starting subtest: invalid-get-prop [100.064728] Subtest invalid-get-prop: SUCCESS (0.000s) [100.199344] [078/171] (902s left) kms_addfb_basic (invalid-get-prop-any) [100.296424] Starting subtest: invalid-get-prop-any [100.297406] Subtest invalid-get-prop-any: SUCCESS (0.000s) [100.437904] [079/171] (901s left) kms_addfb_basic (invalid-set-prop) [100.534352] Starting subtest: invalid-set-prop [100.535223] Subtest invalid-set-prop: SUCCESS (0.000s) [100.670824] [080/171] (901s left) kms_addfb_basic (invalid-set-prop-any) [100.766385] Starting subtest: invalid-set-prop-any [100.767315] Subtest invalid-set-prop-any: SUCCESS (0.000s) [100.912787] [081/171] (901s left) kms_addfb_basic (no-handle) [101.008301] Starting subtest: no-handle [101.009219] Subtest no-handle: SUCCESS (0.000s) [101.144158] [082/171] (901s left) kms_addfb_basic (size-max) [101.280161] Starting subtest: size-max [101.281161] Subtest size-max: SUCCESS (0.000s) [101.384978] [083/171] (900s left) kms_addfb_basic (small-bo) [101.512508] Starting subtest: small-bo [101.513415] Subtest small-bo: SUCCESS (0.000s) [101.616478] [084/171] (900s left) kms_addfb_basic (tile-pitch-mismatch) [101.714177] Starting subtest: tile-pitch-mismatch [101.715092] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [101.868081] [085/171] (900s left) kms_addfb_basic (too-high) [102.002127] Starting subtest: too-high [102.003167] Subtest too-high: SUCCESS (0.001s) [102.108318] [086/171] (900s left) kms_addfb_basic (too-wide) [102.241304] Starting subtest: too-wide [102.242309] Subtest too-wide: SUCCESS (0.000s) [102.332206] [087/171] (900s left) kms_addfb_basic (unused-handle) [102.429053] Starting subtest: unused-handle [102.429924] Subtest unused-handle: SUCCESS (0.000s) [102.566372] [088/171] (899s left) kms_addfb_basic (unused-modifier) [102.663166] Starting subtest: unused-modifier [102.669328] Subtest unused-modifier: SUCCESS (0.000s) [102.796520] [089/171] (899s left) kms_addfb_basic (unused-offsets) [102.891540] Starting subtest: unused-offsets [102.892635] Subtest unused-offsets: SUCCESS (0.000s) [103.030427] [090/171] (899s left) kms_addfb_basic (unused-pitches) [103.127369] Starting subtest: unused-pitches [103.128419] Subtest unused-pitches: SUCCESS (0.000s) [103.255948] [091/171] (899s left) kms_busy (basic) [103.391370] Starting subtest: basic [103.392370] Starting dynamic subtest: flip [104.420224] Dynamic subtest flip: SUCCESS (1.027s) [104.445170] Starting dynamic subtest: modeset [108.207476] Dynamic subtest modeset: SUCCESS (3.786s) [108.208492] Subtest basic: SUCCESS (4.815s) [109.102092] [092/171] (893s left) kms_chamelium_hpd (dp-hpd-fast) [109.552420] Subtest dp-hpd-fast: SKIP (0.000s) [110.419083] [093/171] (892s left) kms_chamelium_edid (dp-edid-read) [110.871190] Subtest dp-edid-read: SKIP (0.000s) [111.761730] [094/171] (890s left) kms_chamelium_frames (dp-crc-fast) [112.210494] Subtest dp-crc-fast: SKIP (0.000s) [113.107242] [095/171] (889s left) kms_chamelium_hpd (hdmi-hpd-fast) [113.542802] Subtest hdmi-hpd-fast: SKIP (0.000s) [114.455191] [096/171] (888s left) kms_chamelium_edid (hdmi-edid-read) [114.900044] Subtest hdmi-edid-read: SKIP (0.000s) [115.781245] [097/171] (886s left) kms_chamelium_frames (hdmi-crc-fast) [116.231419] Subtest hdmi-crc-fast: SKIP (0.000s) [117.137982] [098/171] (885s left) kms_chamelium_hpd (vga-hpd-fast) [117.572103] Subtest vga-hpd-fast: SKIP (0.000s) [118.484101] [099/171] (884s left) kms_chamelium_edid (vga-edid-read) [118.930365] Subtest vga-edid-read: SKIP (0.000s) [119.828134] [100/171] (882s left) kms_prop_blob (basic) [119.944834] Starting subtest: basic [119.945820] Subtest basic: SUCCESS (0.000s) [120.018372] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [120.163541] Starting subtest: basic-busy-flip-before-cursor-atomic [120.165630] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [120.248900] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [120.396646] Starting subtest: basic-busy-flip-before-cursor-legacy [120.398639] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [120.482671] [103/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [120.627223] Starting subtest: basic-flip-after-cursor-atomic [121.953574] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.325s) [122.880498] [104/171] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [123.028113] Starting subtest: basic-flip-after-cursor-legacy [124.362058] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.333s) [125.314979] [105/171] (877s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [125.461417] Starting subtest: basic-flip-after-cursor-varying-size [126.744223] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.283s) [127.681510] [106/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [127.828599] Starting subtest: basic-flip-before-cursor-atomic [129.083446] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.253s) [130.056834] [107/171] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [130.200058] Starting subtest: basic-flip-before-cursor-legacy [131.464560] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.263s) [132.419740] [108/171] (870s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [132.568169] Starting subtest: basic-flip-before-cursor-varying-size [133.907607] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.337s) [134.845841] [109/171] (868s left) kms_flip (basic-flip-vs-dpms) [134.970131] Starting subtest: basic-flip-vs-dpms [134.974953] Starting dynamic subtest: A-eDP1 [137.841652] Dynamic subtest A-eDP1: SUCCESS (2.865s) [137.853754] Starting dynamic subtest: B-eDP1 [140.234108] Dynamic subtest B-eDP1: SUCCESS (2.391s) [140.248369] Starting dynamic subtest: C-eDP1 [142.582999] Dynamic subtest C-eDP1: SUCCESS (2.345s) [142.589303] Subtest basic-flip-vs-dpms: SUCCESS (7.620s) [143.479180] [110/171] (859s left) kms_flip (basic-flip-vs-modeset) [143.601776] Starting subtest: basic-flip-vs-modeset [143.606147] Starting dynamic subtest: A-eDP1 [146.417568] Dynamic subtest A-eDP1: SUCCESS (2.809s) [146.434405] Starting dynamic subtest: B-eDP1 [148.791483] Dynamic subtest B-eDP1: SUCCESS (2.365s) [148.805753] Starting dynamic subtest: C-eDP1 [151.175861] Dynamic subtest C-eDP1: SUCCESS (2.388s) [151.180494] Subtest basic-flip-vs-modeset: SUCCESS (7.579s) [152.056469] [111/171] (850s left) kms_flip (basic-flip-vs-wf_vblank) [152.181882] Starting subtest: basic-flip-vs-wf_vblank [152.184808] Starting dynamic subtest: A-eDP1 [154.458020] Dynamic subtest A-eDP1: SUCCESS (2.273s) [154.472184] Starting dynamic subtest: B-eDP1 [156.763351] Dynamic subtest B-eDP1: SUCCESS (2.302s) [156.774303] Starting dynamic subtest: C-eDP1 [159.064211] Dynamic subtest C-eDP1: SUCCESS (2.301s) [159.074085] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.889s) [160.322094] [112/171] (842s left) kms_flip (basic-plain-flip) [160.443548] Starting subtest: basic-plain-flip [160.448191] Starting dynamic subtest: A-eDP1 [162.439351] Dynamic subtest A-eDP1: SUCCESS (1.985s) [162.466151] Starting dynamic subtest: B-eDP1 [164.487884] Dynamic subtest B-eDP1: SUCCESS (2.039s) [164.517952] Starting dynamic subtest: C-eDP1 [166.539173] Dynamic subtest C-eDP1: SUCCESS (2.035s) [166.550028] Subtest basic-plain-flip: SUCCESS (6.106s) [167.880543] [113/171] (835s left) kms_force_connector_basic (force-connector-state) [168.015585] Starting subtest: force-connector-state [168.656867] Subtest force-connector-state: SUCCESS (0.643s) [169.657847] [114/171] (833s left) kms_force_connector_basic (force-edid) [169.794105] Starting subtest: force-edid [169.827513] Subtest force-edid: SUCCESS (0.035s) [170.033678] [115/171] (832s left) kms_force_connector_basic (force-load-detect) [170.168600] Starting subtest: force-load-detect [170.170653] Subtest force-load-detect: SKIP (0.000s) [170.318346] [116/171] (832s left) kms_force_connector_basic (prune-stale-modes) [170.448588] Starting subtest: prune-stale-modes [170.480754] Subtest prune-stale-modes: SUCCESS (0.034s) [170.669941] [117/171] (832s left) kms_frontbuffer_tracking (basic) [170.810915] Starting subtest: basic [173.648702] Subtest basic: SUCCESS (2.839s) [173.764428] [118/171] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [173.906987] Starting subtest: compare-crc-sanitycheck-xr24 [173.908070] Starting dynamic subtest: pipe-A-eDP-1 [174.537160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s) [174.547348] Starting dynamic subtest: pipe-B-eDP-1 [175.855113] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.315s) [175.868703] Starting dynamic subtest: pipe-C-eDP-1 [177.172926] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s) [177.173860] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.267s) [178.086448] [119/171] (825s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [178.219234] Starting subtest: compare-crc-sanitycheck-nv12 [178.220210] Starting dynamic subtest: pipe-A-eDP-1 [178.222126] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [178.233091] Starting dynamic subtest: pipe-B-eDP-1 [178.234964] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [178.243482] Starting dynamic subtest: pipe-C-eDP-1 [178.245351] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [178.247259] Subtest compare-crc-sanitycheck-nv12: SKIP (0.010s) [178.312405] [120/171] (824s left) kms_pipe_crc_basic (hang-read-crc) [178.446428] Starting subtest: hang-read-crc [178.447441] Starting dynamic subtest: pipe-A-eDP-1 [180.703270] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.255s) [180.716852] Starting dynamic subtest: pipe-B-eDP-1 [183.649116] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.940s) [183.671966] Starting dynamic subtest: pipe-C-eDP-1 [186.559339] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.905s) [186.560424] Subtest hang-read-crc: SUCCESS (8.114s) [187.517123] [121/171] (815s left) kms_pipe_crc_basic (nonblocking-crc) [187.668845] Starting subtest: nonblocking-crc [187.671393] Starting dynamic subtest: pipe-A-eDP-1 [188.453417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s) [188.467069] Starting dynamic subtest: pipe-B-eDP-1 [189.985497] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.528s) [190.006329] Starting dynamic subtest: pipe-C-eDP-1 [191.523830] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.529s) [191.525265] Subtest nonblocking-crc: SUCCESS (3.855s) [192.448441] [122/171] (810s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [192.596543] Starting subtest: nonblocking-crc-frame-sequence [192.597604] Starting dynamic subtest: pipe-A-eDP-1 [193.393188] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s) [193.406683] Starting dynamic subtest: pipe-B-eDP-1 [194.934721] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.536s) [194.949187] Starting dynamic subtest: pipe-C-eDP-1 [196.453623] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.515s) [196.454928] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.860s) [197.385286] [123/171] (805s left) kms_pipe_crc_basic (read-crc) [197.534883] Starting subtest: read-crc [197.537472] Starting dynamic subtest: pipe-A-eDP-1 [198.272772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s) [198.284625] Starting dynamic subtest: pipe-B-eDP-1 [199.735595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s) [199.751925] Starting dynamic subtest: pipe-C-eDP-1 [201.200705] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.461s) [201.202289] Subtest read-crc: SUCCESS (3.666s) [202.109647] [124/171] (801s left) kms_pipe_crc_basic (read-crc-frame-sequence) [202.258964] Starting subtest: read-crc-frame-sequence [202.262453] Starting dynamic subtest: pipe-A-eDP-1 [202.988847] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s) [203.022933] Starting dynamic subtest: pipe-B-eDP-1 [204.445787] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.451s) [204.463241] Starting dynamic subtest: pipe-C-eDP-1 [205.901727] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.454s) [205.902968] Subtest read-crc-frame-sequence: SUCCESS (3.644s) [206.846354] [125/171] (796s left) kms_psr (primary_page_flip) [206.995544] Starting subtest: primary_page_flip [208.978739] Subtest primary_page_flip: SUCCESS (1.984s) [209.919482] [126/171] (793s left) kms_psr (cursor_plane_move) [210.064784] Starting subtest: cursor_plane_move [211.971326] Subtest cursor_plane_move: SUCCESS (1.906s) [212.925121] [127/171] (790s left) kms_psr (sprite_plane_onoff) [213.072653] Starting subtest: sprite_plane_onoff [215.053102] Subtest sprite_plane_onoff: SUCCESS (1.976s) [215.996932] [128/171] (787s left) kms_psr (primary_mmap_gtt) [216.148111] Starting subtest: primary_mmap_gtt [218.108636] Subtest primary_mmap_gtt: SUCCESS (1.958s) [219.070209] [129/171] (784s left) kms_setmode (basic-clone-single-crtc) [219.180935] Starting subtest: basic-clone-single-crtc [219.183762] Subtest basic-clone-single-crtc: SKIP (0.001s) [219.306061] [130/171] (784s left) i915_pm_backlight (basic-brightness) [219.460854] Starting subtest: basic-brightness [219.586146] Starting dynamic subtest: eDP-1 [220.179079] Dynamic subtest eDP-1: SUCCESS (0.600s) [220.180594] Subtest basic-brightness: SUCCESS (0.720s) [221.124903] [131/171] (782s left) i915_pm_rpm (basic-pci-d3-state) [222.894401] Starting subtest: basic-pci-d3-state [227.468283] Subtest basic-pci-d3-state: SUCCESS (4.582s) [227.626063] [132/171] (775s left) i915_pm_rpm (basic-rte) [227.731906] Starting subtest: basic-rte [233.895936] Subtest basic-rte: SUCCESS (6.161s) [239.258865] [133/171] (764s left) i915_pm_rps (basic-api) [239.371377] Starting subtest: basic-api [239.376324] Subtest basic-api: SUCCESS (0.005s) [239.486906] [134/171] (763s left) prime_self_import (basic-llseek-bad) [239.599847] Starting subtest: basic-llseek-bad [239.602247] Subtest basic-llseek-bad: SUCCESS (0.002s) [239.731772] [135/171] (763s left) prime_self_import (basic-llseek-size) [239.837254] Starting subtest: basic-llseek-size [239.842054] Subtest basic-llseek-size: SUCCESS (0.003s) [239.980207] [136/171] (763s left) prime_self_import (basic-with_fd_dup) [240.086458] Starting subtest: basic-with_fd_dup [240.091349] Subtest basic-with_fd_dup: SUCCESS (0.003s) [240.217860] [137/171] (763s left) prime_self_import (basic-with_one_bo) [240.323030] Starting subtest: basic-with_one_bo [240.327690] Subtest basic-with_one_bo: SUCCESS (0.004s) [240.401165] [138/171] (763s left) prime_self_import (basic-with_one_bo_two_files) [240.507314] Starting subtest: basic-with_one_bo_two_files [240.512355] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [240.610330] [139/171] (762s left) prime_self_import (basic-with_two_bos) [240.724334] Starting subtest: basic-with_two_bos [240.728320] Subtest basic-with_two_bos: SUCCESS (0.004s) [240.835155] [140/171] (762s left) prime_vgem (basic-fence-flip) [240.975442] Starting subtest: basic-fence-flip [241.468053] Subtest basic-fence-flip: SUCCESS (0.492s) [241.617597] [141/171] (762s left) prime_vgem (basic-fence-mmap) [241.754655] Starting subtest: basic-fence-mmap [241.791220] Subtest basic-fence-mmap: SUCCESS (0.036s) [241.894247] [142/171] (761s left) prime_vgem (basic-fence-read) [242.045260] Starting subtest: basic-fence-read [242.103925] Subtest basic-fence-read: SUCCESS (0.059s) [242.180139] [143/171] (761s left) prime_vgem (basic-gtt) [242.328342] Starting subtest: basic-gtt [242.344364] Subtest basic-gtt: SUCCESS (0.016s) [242.471459] [144/171] (761s left) prime_vgem (basic-read) [242.613348] Starting subtest: basic-read [242.639394] Subtest basic-read: SUCCESS (0.026s) [242.752389] [145/171] (761s left) prime_vgem (basic-write) [242.896988] Starting subtest: basic-write [242.925921] Subtest basic-write: SUCCESS (0.029s) [243.000235] [146/171] (760s left) vgem_basic (setversion) [243.146621] Starting subtest: setversion [243.148917] Subtest setversion: SUCCESS (0.000s) [243.212946] [147/171] (760s left) vgem_basic (create) [243.351964] Starting subtest: create [243.353076] Subtest create: SUCCESS (0.000s) [243.428218] [148/171] (760s left) vgem_basic (debugfs) [243.558474] Starting subtest: debugfs [243.559970] Subtest debugfs: SUCCESS (0.001s) [243.630747] [149/171] (760s left) vgem_basic (dmabuf-export) [243.767822] Starting subtest: dmabuf-export [243.770105] Subtest dmabuf-export: SUCCESS (0.002s) [243.893245] [150/171] (760s left) vgem_basic (dmabuf-fence) [244.025461] Starting subtest: dmabuf-fence [244.026587] Subtest dmabuf-fence: SUCCESS (0.001s) [244.085487] [151/171] (759s left) vgem_basic (dmabuf-fence-before) [244.231353] Starting subtest: dmabuf-fence-before [244.232589] Subtest dmabuf-fence-before: SUCCESS (0.000s) [244.303378] [152/171] (759s left) vgem_basic (dmabuf-mmap) [244.444025] Starting subtest: dmabuf-mmap [244.462183] Subtest dmabuf-mmap: SUCCESS (0.018s) [244.520962] [153/171] (759s left) vgem_basic (mmap) [244.668982] Starting subtest: mmap [244.679483] Subtest mmap: SUCCESS (0.013s) [244.743689] [154/171] (759s left) vgem_basic (second-client) [244.890427] Starting subtest: second-client [244.921855] Subtest second-client: SUCCESS (0.031s) [244.982783] [155/171] (759s left) vgem_basic (sysfs) [245.129974] Starting subtest: sysfs [245.131203] Subtest sysfs: SUCCESS (0.001s) [245.188315] [156/171] (758s left) core_hotunplug (unbind-rebind) [245.352092] Starting subtest: unbind-rebind [247.675476] Subtest unbind-rebind: SUCCESS (2.323s) [247.716219] [157/171] (756s left) vgem_basic (unload) [247.829432] Starting subtest: unload [276.938296] Subtest unload: SUCCESS (29.072s) [277.049622] [158/171] (727s left) i915_module_load (reload) [277.172192] Starting subtest: reload [280.514905] Subtest reload: SUCCESS (3.342s) [280.546509] [159/171] (723s left) gem_lmem_swapping (basic) [280.755319] Subtest basic: SKIP (0.000s) [280.816197] [160/171] (723s left) gem_lmem_swapping (parallel-random-engines) [280.928233] Subtest parallel-random-engines: SKIP (0.000s) [280.981671] [161/171] (723s left) gem_lmem_swapping (random-engines) [281.090716] Subtest random-engines: SKIP (0.000s) [281.132474] [162/171] (723s left) gem_lmem_swapping (verify-random) [281.244201] Subtest verify-random: SKIP (0.000s) [281.283696] [163/171] (722s left) i915_pm_rpm (module-reload) [283.896390] Starting subtest: module-reload [300.388705] Subtest module-reload: SUCCESS (16.482s) [300.428778] [164/171] (703s left) i915_selftest (live) [300.549152] Starting subtest: live [300.550252] Starting dynamic subtest: sanitycheck [302.271703] Dynamic subtest sanitycheck: SUCCESS (1.713s) [302.279272] Starting dynamic subtest: uncore [303.925796] Dynamic subtest uncore: SUCCESS (1.652s) [303.934180] Starting dynamic subtest: workarounds [305.779781] Dynamic subtest workarounds: SUCCESS (1.852s) [305.787965] Starting dynamic subtest: gt_engines [307.899740] Dynamic subtest gt_engines: SUCCESS (2.118s) [307.908153] Starting dynamic subtest: gt_timelines [318.081789] Dynamic subtest gt_timelines: SUCCESS (10.180s) [318.090200] Starting dynamic subtest: gt_contexts [319.880576] Dynamic subtest gt_contexts: SUCCESS (1.797s) [319.890922] Starting dynamic subtest: gt_lrc [324.034089] Dynamic subtest gt_lrc: SUCCESS (4.151s) [324.043796] Starting dynamic subtest: gt_mocs [325.891732] Dynamic subtest gt_mocs: SUCCESS (1.856s) [325.899351] Starting dynamic subtest: gt_pm [331.864819] Dynamic subtest gt_pm: SUCCESS (5.969s) [331.875271] Starting dynamic subtest: gt_heartbeat [333.627724] Dynamic subtest gt_heartbeat: SUCCESS (1.763s) [333.639161] Starting dynamic subtest: gt_tlb [336.184705] Dynamic subtest gt_tlb: SUCCESS (2.555s) [336.192430] Starting dynamic subtest: requests [343.728922] Dynamic subtest requests: SUCCESS (7.542s) [343.741254] Starting dynamic subtest: migrate [348.232765] Dynamic subtest migrate: SUCCESS (4.502s) [348.241523] Starting dynamic subtest: active [349.880736] Dynamic subtest active: SUCCESS (1.646s) [349.888410] Starting dynamic subtest: objects [352.690776] Dynamic subtest objects: SUCCESS (2.808s) [352.702248] Starting dynamic subtest: mman [357.856513] Dynamic subtest mman: SUCCESS (5.164s) [357.863520] Starting dynamic subtest: dmabuf [359.544752] Dynamic subtest dmabuf: SUCCESS (1.687s) [359.553227] Starting dynamic subtest: vma [361.203685] Dynamic subtest vma: SUCCESS (1.657s) [361.212292] Starting dynamic subtest: coherency [364.085681] Dynamic subtest coherency: SUCCESS (2.880s) [364.096142] Starting dynamic subtest: gtt [372.684776] Dynamic subtest gtt: SUCCESS (8.597s) [372.692543] Starting dynamic subtest: gem [374.620921] Dynamic subtest gem: SUCCESS (1.934s) [374.630427] Starting dynamic subtest: evict [377.913703] Dynamic subtest evict: SUCCESS (3.291s) [377.921483] Starting dynamic subtest: hugepages [384.886639] Dynamic subtest hugepages: SUCCESS (6.971s) [384.895217] Starting dynamic subtest: gem_contexts [399.496816] Dynamic subtest gem_contexts: SUCCESS (14.608s) [399.504654] Starting dynamic subtest: client [401.198771] Dynamic subtest client: SUCCESS (1.700s) [401.206623] Starting dynamic subtest: gem_migrate [402.864906] Dynamic subtest gem_migrate: SUCCESS (1.664s) [402.874539] Starting dynamic subtest: reset [405.236676] Dynamic subtest reset: SUCCESS (2.370s) [405.248344] Starting dynamic subtest: memory_region [406.887739] Dynamic subtest memory_region: SUCCESS (1.649s) [406.896398] Starting dynamic subtest: hangcheck [431.006913] Dynamic subtest hangcheck: SUCCESS (24.117s) [431.015823] Starting dynamic subtest: execlists [440.552715] Dynamic subtest execlists: SUCCESS (9.544s) [440.560465] Starting dynamic subtest: ring_submission [442.244951] Dynamic subtest ring_submission: SUCCESS (1.691s) [442.256183] Starting dynamic subtest: perf [444.086690] Dynamic subtest perf: SUCCESS (1.840s) [444.094369] Starting dynamic subtest: slpc [445.744255] Dynamic subtest slpc: SUCCESS (1.656s) [445.755735] Starting dynamic subtest: guc [447.401812] Dynamic subtest guc: SUCCESS (1.656s) [447.413907] Starting dynamic subtest: guc_multi_lrc [449.080752] Dynamic subtest guc_multi_lrc: SUCCESS (1.677s) [449.092398] Starting dynamic subtest: guc_hang [450.742794] Dynamic subtest guc_hang: SUCCESS (1.660s) [450.755389] Starting dynamic subtest: late_gt_pm [452.488082] Dynamic subtest late_gt_pm: SUCCESS (1.743s) [452.489300] Subtest live: SUCCESS (151.931s) [452.727895] [165/171] (551s left) dmabuf (all-tests) [452.839644] Starting subtest: all-tests [452.840711] Starting dynamic subtest: sanitycheck [452.913236] Dynamic subtest sanitycheck: SUCCESS (0.071s) [452.954485] Starting dynamic subtest: dma_fence [453.121709] Dynamic subtest dma_fence: SUCCESS (0.198s) [453.134738] Starting dynamic subtest: dma_fence_chain [469.140606] Dynamic subtest dma_fence_chain: SUCCESS (16.007s) [469.173293] Starting dynamic subtest: dma_fence_unwrap [469.216385] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [469.235481] Starting dynamic subtest: dma_resv [469.304052] Dynamic subtest dma_resv: SUCCESS (0.085s) [469.310439] Subtest all-tests: SUCCESS (16.466s) [469.358423] [166/171] (534s left) i915_suspend (basic-s2idle-without-i915) [469.478297] Starting subtest: basic-s2idle-without-i915 [489.415660] Subtest basic-s2idle-without-i915: SUCCESS (4.147s) [491.769312] [167/171] (530s left) i915_suspend (basic-s3-without-i915) [491.886725] Starting subtest: basic-s3-without-i915 [512.459973] Subtest basic-s3-without-i915: SUCCESS (4.418s) [515.873861] [168/171] (525s left) gem_exec_suspend (basic-s0) [516.034940] Starting subtest: basic-S0 [516.036027] Starting dynamic subtest: smem [534.452918] Dynamic subtest smem: SUCCESS (3.285s) [534.454001] Subtest basic-S0: SUCCESS (3.287s) [536.631944] [169/171] (521s left) gem_exec_suspend (basic-s3) [536.778335] Starting subtest: basic-S3 [536.779478] Starting dynamic subtest: smem [557.978464] Dynamic subtest smem: SUCCESS (4.807s) [557.979477] Subtest basic-S3: SUCCESS (4.809s) [560.290154] [170/171] (516s left) kms_chamelium_hpd (common-hpd-after-suspend) [560.782399] Subtest common-hpd-after-suspend: SKIP (0.000s) [561.667324] [171/171] (515s left) kms_pipe_crc_basic (suspend-read-crc) [561.816863] Starting subtest: suspend-read-crc [561.820237] Starting dynamic subtest: pipe-A-eDP-1 [581.588392] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.377s) [581.606669] Starting dynamic subtest: pipe-B-eDP-1 [602.797294] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.233s) [602.811746] Starting dynamic subtest: pipe-C-eDP-1 [623.542837] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.029s) [623.543999] Subtest suspend-read-crc: SUCCESS (11.648s) [626.445399] Closing watchdogs Done.