Data importer The conversion could not be started, or failed due to an error. Please check the log files. Sorry about this :( #9426

mlause · 2024-11-04T17:21:11Z

mlause
Nov 4, 2024

I've just started to get this issue today. Everything was fine prior to today. The logs don't show much. I get this message once the error shows, and it repeats until the data importer stops.

I've tried to copy the log along the steps in the data importer with the conversion error being listed. What could be the issue?

[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep("upload-files")
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:10:00] production.DEBUG: Now at App\Http\Controllers\Import\UploadController::upload
[2024-11-04 11:10:00] production.DEBUG: CAMT.053 Check on file: negative
[2024-11-04 11:10:00] production.DEBUG: DOMDocument::loadXML(): Start tag expected, '<' not found in Entity, line: 1
[2024-11-04 11:10:00] production.DEBUG: Counted 0x "\n\r" EOL in upload.
[2024-11-04 11:10:00] production.DEBUG: Counted 46x "\r\n" EOL in upload.
[2024-11-04 11:10:00] production.DEBUG: Conclusion: "\r\n" is the EOL in this file.
[2024-11-04 11:10:00] production.DEBUG: Counted 46x "\n" EOL in upload.
[2024-11-04 11:10:00] production.DEBUG: Counted 46x "\r" EOL in upload.
[2024-11-04 11:10:00] production.WARNING: Have already stored a file under key "23aa886f2c771cb459e72e8135cad5c42b657f24051f4dd2faaa49d430b1cdc7", so the content is unchanged from last time.
[2024-11-04 11:10:00] production.DEBUG: storeContent: Stored 1150 bytes in file "23aa886f2c771cb459e72e8135cad5c42b657f24051f4dd2faaa49d430b1cdc7"
10.10.60.10 - - [04/Nov/2024:11:10:00 -0600] "POST /upload HTTP/1.1" 302 1599 "http://url:8080/upload" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep("configuration")
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:10:00] production.DEBUG: Now at App\Http\Controllers\Import\ConfigurationController::index
[2024-11-04 11:10:00] production.DEBUG: CAMT.053 Check of content: negative
10.10.60.10 - - [04/Nov/2024:11:10:00 -0600] "GET /import/configure HTTP/1.1" 200 6667 "http://url:8080/upload" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep("configuration")
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:10:00] production.DEBUG: Method App\Http\Controllers\Import\ConfigurationController::phpDate
10.10.60.10 - - [04/Nov/2024:11:10:00 -0600] "GET /import/php_date?format=Y-m-d HTTP/1.1" 200 1151 "http://url:8080/import/configure" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
127.0.0.1 - - [04/Nov/2024:11:10:47 -0600] "GET /health HTTP/1.1" 200 1105 "-" "User-Agent: Firefly III Health Checker/2.2"
[2024-11-04 11:11:26] production.DEBUG: isReadyForFileStep("configuration")
[2024-11-04 11:11:26] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:11:26] production.DEBUG: Method App\Http\Controllers\Import\ConfigurationController::phpDate
10.10.60.10 - - [04/Nov/2024:11:11:26 -0600] "GET /import/php_date?format=n%2Fj%2Fy HTTP/1.1" 200 1151 "http://url:8080/import/configure" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:11:35] production.DEBUG: isReadyForFileStep("configuration")
[2024-11-04 11:11:35] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:11:35] production.DEBUG: Now running App\Http\Controllers\Import\ConfigurationController::postIndex
[2024-11-04 11:11:35] production.DEBUG: Now in updateDateRange()
[2024-11-04 11:11:35] production.DEBUG: Range is null, set all to NULL.
[2024-11-04 11:11:35] production.DEBUG: storeContent: Stored 1088 bytes in file "50b1ca353c79c8dd9acfd53a484ed6bc998c308799e1600ac8f94760306490a2"
[2024-11-04 11:11:35] production.DEBUG: Configuration debug: Connection ID is "0"
10.10.60.10 - - [04/Nov/2024:11:11:35 -0600] "POST /import/configure HTTP/1.1" 302 1579 "http://url:8080/import/configure" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:11:35] production.DEBUG: isReadyForFileStep("define-roles")
[2024-11-04 11:11:35] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:11:35] production.DEBUG: Now in Role controller
[2024-11-04 11:11:35] production.DEBUG: Detected file headers: ["Date","Description","Debit"]
10.10.60.10 - - [04/Nov/2024:11:11:35 -0600] "GET /import/roles HTTP/1.1" 200 4695 "http://url:8080/import/configure" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
text error warn system array login

[2024-11-04 11:08:26] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:26] production.DEBUG: Now at App\Services\Spectre\AuthenticationValidator::validate
[2024-11-04 11:08:26] production.DEBUG: No Spectre App ID in hasAppId() session, will return config variable.
[2024-11-04 11:08:26] production.DEBUG: No Spectre secret in hasSecret(), will return config variable.
[2024-11-04 11:08:26] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:26] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:26] production.DEBUG: Now at App\Services\Nordigen\AuthenticationValidator::validate
[2024-11-04 11:08:26] production.DEBUG: Now at App\Services\SimpleFIN\AuthenticationValidator::validate
[2024-11-04 11:08:26] production.DEBUG: No Nordigen ID in hasId() session, will return config variable.
[2024-11-04 11:08:26] production.DEBUG: No Nordigen key in hasKey() session, will return config variable.
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /validate/spectre HTTP/1.1" 200 1147 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /validate/simplefin HTTP/1.1" 200 1144 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /validate/nordigen HTTP/1.1" 200 1147 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:26] production.DEBUG: Now at App\Http\Controllers\IndexController::flush
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /flush HTTP/1.1" 302 1824 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:26] production.DEBUG: Now in App\Http\Controllers\IndexController::index
[2024-11-04 11:08:26] production.DEBUG: App\Services\Shared\Authentication\SecretManager::hasValidSecrets
[2024-11-04 11:08:26] production.DEBUG: No valid secrets, redirect to token.index
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET / HTTP/1.1" 302 1543 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:26] production.DEBUG: Now at App\Http\Controllers\TokenController::index
[2024-11-04 11:08:26] production.DEBUG: No access token in hasAccessToken() session, will return config variable.
[2024-11-04 11:08:26] production.DEBUG: No client id in hasClientId() session, will return config variable.
[2024-11-04 11:08:26] production.DEBUG: No base url in getBaseUrl() session, will return config variable.
[2024-11-04 11:08:26] production.DEBUG: No vanity url in getVanityUrl() session, will return config variable.
[2024-11-04 11:08:26] production.INFO: The following configuration information was found:
[2024-11-04 11:08:26] production.INFO: Personal Access Token: "eyJ0eXAiOiJKV1QiLCJhbGciO" (limited to 25 chars if present)
[2024-11-04 11:08:26] production.INFO: Client ID : "0"
[2024-11-04 11:08:26] production.INFO: Base URL : "http://url:8080"
[2024-11-04 11:08:26] production.INFO: Vanity URL : "http://url:8080"
[2024-11-04 11:08:26] production.DEBUG: Found personal access token + URL "http://url:8080" in config, set cookie and return to index.
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /token HTTP/1.1" 302 1513 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:26] production.DEBUG: Now in App\Http\Controllers\IndexController::index
[2024-11-04 11:08:26] production.DEBUG: App\Services\Shared\Authentication\SecretManager::hasValidSecrets
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET / HTTP/1.1" 200 3582 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:26] production.DEBUG: Now at App\Http\Controllers\TokenController::doValidate
[2024-11-04 11:08:26] production.DEBUG: Now trying to authenticate with Firefly III at http://url:8080
[2024-11-04 11:08:26] production.DEBUG: Result is {"result":"OK","message":null}
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /token/validate HTTP/1.1" 200 1158 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:26] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:26] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:26] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:26] production.DEBUG: Now at App\Services\Nordigen\AuthenticationValidator::validate
[2024-11-04 11:08:26] production.DEBUG: Now at App\Services\SimpleFIN\AuthenticationValidator::validate
[2024-11-04 11:08:26] production.DEBUG: Now at App\Services\Spectre\AuthenticationValidator::validate
[2024-11-04 11:08:26] production.DEBUG: No Nordigen ID in hasId() session, will return config variable.
[2024-11-04 11:08:26] production.DEBUG: No Spectre App ID in hasAppId() session, will return config variable.
[2024-11-04 11:08:26] production.DEBUG: No Spectre secret in hasSecret(), will return config variable.
[2024-11-04 11:08:26] production.DEBUG: No Nordigen key in hasKey() session, will return config variable.
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /validate/simplefin HTTP/1.1" 200 1144 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /validate/spectre HTTP/1.1" 200 1147 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
10.10.60.10 - - [04/Nov/2024:11:08:26 -0600] "GET /validate/nordigen HTTP/1.1" 200 1147 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:33] production.DEBUG: Now at App\Http\Controllers\IndexController::flush
10.10.60.10 - - [04/Nov/2024:11:08:33 -0600] "GET /flush HTTP/1.1" 302 1825 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:33] production.DEBUG: Now in App\Http\Controllers\IndexController::index
[2024-11-04 11:08:33] production.DEBUG: App\Services\Shared\Authentication\SecretManager::hasValidSecrets
[2024-11-04 11:08:33] production.DEBUG: No valid secrets, redirect to token.index
10.10.60.10 - - [04/Nov/2024:11:08:33 -0600] "GET / HTTP/1.1" 302 1543 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:33] production.DEBUG: Now at App\Http\Controllers\TokenController::index
[2024-11-04 11:08:33] production.DEBUG: No access token in hasAccessToken() session, will return config variable.
[2024-11-04 11:08:33] production.DEBUG: No client id in hasClientId() session, will return config variable.
[2024-11-04 11:08:33] production.DEBUG: No base url in getBaseUrl() session, will return config variable.
[2024-11-04 11:08:33] production.DEBUG: No vanity url in getVanityUrl() session, will return config variable.
[2024-11-04 11:08:33] production.INFO: The following configuration information was found:
[2024-11-04 11:08:33] production.INFO: Personal Access Token: "eyJ0eXAiOiJKV1QiLCJhbGciO" (limited to 25 chars if present)
[2024-11-04 11:08:33] production.INFO: Client ID : "0"
[2024-11-04 11:08:33] production.INFO: Base URL : "http://url:8080"
[2024-11-04 11:08:33] production.INFO: Vanity URL : "http://url:8080"
[2024-11-04 11:08:33] production.DEBUG: Found personal access token + URL "http://url:8080" in config, set cookie and return to index.
10.10.60.10 - - [04/Nov/2024:11:08:33 -0600] "GET /token HTTP/1.1" 302 1513 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:33] production.DEBUG: Now in App\Http\Controllers\IndexController::index
[2024-11-04 11:08:33] production.DEBUG: App\Services\Shared\Authentication\SecretManager::hasValidSecrets
10.10.60.10 - - [04/Nov/2024:11:08:33 -0600] "GET / HTTP/1.1" 200 3583 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:33] production.DEBUG: Now at App\Http\Controllers\TokenController::doValidate
[2024-11-04 11:08:33] production.DEBUG: Now trying to authenticate with Firefly III at http://url:8080
[2024-11-04 11:08:33] production.DEBUG: Result is {"result":"OK","message":null}
10.10.60.10 - - [04/Nov/2024:11:08:33 -0600] "GET /token/validate HTTP/1.1" 200 1158 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:08:33] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:33] production.DEBUG: Now at App\Services\Spectre\AuthenticationValidator::validate
[2024-11-04 11:08:33] production.DEBUG: No Spectre App ID in hasAppId() session, will return config variable.
[2024-11-04 11:08:33] production.DEBUG: No Spectre secret in hasSecret(), will return config variable.
[2024-11-04 11:08:33] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:33] production.DEBUG: Now at App\Services\Nordigen\AuthenticationValidator::validate
[2024-11-04 11:08:33] production.DEBUG: No Nordigen ID in hasId() session, will return config variable.
[2024-11-04 11:08:33] production.DEBUG: No Nordigen key in hasKey() session, will return config variable.
[2024-11-04 11:08:33] production.DEBUG: isReadyForBasicStep("service-validation")
[2024-11-04 11:08:33] production.DEBUG: Now at App\Services\SimpleFIN\AuthenticationValidator::validate
10.10.60.10 - - [04/Nov/2024:11:08:33 -0600] "GET /validate/spectre HTTP/1.1" 200 1147 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
10.10.60.10 - - [04/Nov/2024:11:08:33 -0600] "GET /validate/simplefin HTTP/1.1" 200 1145 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
10.10.60.10 - - [04/Nov/2024:11:08:33 -0600] "GET /validate/nordigen HTTP/1.1" 200 1148 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
127.0.0.1 - - [04/Nov/2024:11:08:47 -0600] "GET /health HTTP/1.1" 200 1105 "-" "User-Agent: Firefly III Health Checker/2.2"
127.0.0.1 - - [04/Nov/2024:11:09:47 -0600] "GET /health HTTP/1.1" 200 1105 "-" "User-Agent: Firefly III Health Checker/2.2"
[2024-11-04 11:09:51] production.DEBUG: Now in App\Http\Controllers\IndexController::postIndex
[2024-11-04 11:09:51] production.DEBUG: file is a valid flow, redirect to authenticate.
10.10.60.10 - - [04/Nov/2024:11:09:51 -0600] "POST / HTTP/1.1" 302 1890 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:09:51] production.DEBUG: Now in AuthenticateController, calling middleware.
[2024-11-04 11:09:51] production.DEBUG: isReadyForFileStep("authenticate")
[2024-11-04 11:09:51] production.DEBUG: isReadyForFileStep: Return false
[2024-11-04 11:09:51] production.DEBUG: redirectToCorrectFileStep("authenticate")
[2024-11-04 11:09:51] production.DEBUG: Return redirect to "http://url:8080/upload"
10.10.60.10 - - [04/Nov/2024:11:09:51 -0600] "GET /authenticate HTTP/1.1" 302 1548 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:09:51] production.DEBUG: isReadyForFileStep("upload-files")
[2024-11-04 11:09:51] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:09:51] production.DEBUG: Now at App\Http\Controllers\Import\UploadController::index
[2024-11-04 11:09:51] production.DEBUG: Going to check directory for config files: /var/www/html/storage/configurations
[2024-11-04 11:09:51] production.DEBUG: List of files:
10.10.60.10 - - [04/Nov/2024:11:09:51 -0600] "GET /upload HTTP/1.1" 200 3065 "http://url:8080/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep("upload-files")
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:10:00] production.DEBUG: Now at App\Http\Controllers\Import\UploadController::upload
[2024-11-04 11:10:00] production.DEBUG: CAMT.053 Check on file: negative
[2024-11-04 11:10:00] production.DEBUG: DOMDocument::loadXML(): Start tag expected, '<' not found in Entity, line: 1
[2024-11-04 11:10:00] production.DEBUG: Counted 0x "\n\r" EOL in upload.
[2024-11-04 11:10:00] production.DEBUG: Counted 46x "\r\n" EOL in upload.
[2024-11-04 11:10:00] production.DEBUG: Conclusion: "\r\n" is the EOL in this file.
[2024-11-04 11:10:00] production.DEBUG: Counted 46x "\n" EOL in upload.
[2024-11-04 11:10:00] production.DEBUG: Counted 46x "\r" EOL in upload.
[2024-11-04 11:10:00] production.WARNING: Have already stored a file under key "23aa886f2c771cb459e72e8135cad5c42b657f24051f4dd2faaa49d430b1cdc7", so the content is unchanged from last time.
[2024-11-04 11:10:00] production.DEBUG: storeContent: Stored 1150 bytes in file "23aa886f2c771cb459e72e8135cad5c42b657f24051f4dd2faaa49d430b1cdc7"
10.10.60.10 - - [04/Nov/2024:11:10:00 -0600] "POST /upload HTTP/1.1" 302 1599 "http://url:8080/upload" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep("configuration")
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:10:00] production.DEBUG: Now at App\Http\Controllers\Import\ConfigurationController::index
[2024-11-04 11:10:00] production.DEBUG: CAMT.053 Check of content: negative
10.10.60.10 - - [04/Nov/2024:11:10:00 -0600] "GET /import/configure HTTP/1.1" 200 6667 "http://url:8080/upload" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep("configuration")
[2024-11-04 11:10:00] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:10:00] production.DEBUG: Method App\Http\Controllers\Import\ConfigurationController::phpDate
10.10.60.10 - - [04/Nov/2024:11:10:00 -0600] "GET /import/php_date?format=Y-m-d HTTP/1.1" 200 1151 "http://url:8080/import/configure" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
127.0.0.1 - - [04/Nov/2024:11:10:47 -0600] "GET /health HTTP/1.1" 200 1105 "-" "User-Agent: Firefly III Health Checker/2.2"
[2024-11-04 11:11:26] production.DEBUG: isReadyForFileStep("configuration")
[2024-11-04 11:11:26] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:11:26] production.DEBUG: Method App\Http\Controllers\Import\ConfigurationController::phpDate
10.10.60.10 - - [04/Nov/2024:11:11:26 -0600] "GET /import/php_date?format=n%2Fj%2Fy HTTP/1.1" 200 1151 "http://url:8080/import/configure" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:11:35] production.DEBUG: isReadyForFileStep("configuration")
[2024-11-04 11:11:35] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:11:35] production.DEBUG: Now running App\Http\Controllers\Import\ConfigurationController::postIndex
[2024-11-04 11:11:35] production.DEBUG: Now in updateDateRange()
[2024-11-04 11:11:35] production.DEBUG: Range is null, set all to NULL.
[2024-11-04 11:11:35] production.DEBUG: storeContent: Stored 1088 bytes in file "50b1ca353c79c8dd9acfd53a484ed6bc998c308799e1600ac8f94760306490a2"
[2024-11-04 11:11:35] production.DEBUG: Configuration debug: Connection ID is "0"
10.10.60.10 - - [04/Nov/2024:11:11:35 -0600] "POST /import/configure HTTP/1.1" 302 1579 "http://url:8080/import/configure" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:11:35] production.DEBUG: isReadyForFileStep("define-roles")
[2024-11-04 11:11:35] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:11:35] production.DEBUG: Now in Role controller
[2024-11-04 11:11:35] production.DEBUG: Detected file headers: ["Date","Description","Debit"]
10.10.60.10 - - [04/Nov/2024:11:11:35 -0600] "GET /import/roles HTTP/1.1" 200 4695 "http://url:8080/import/configure" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
127.0.0.1 - - [04/Nov/2024:11:11:47 -0600] "GET /health HTTP/1.1" 200 1105 "-" "User-Agent: Firefly III Health Checker/2.2"
[2024-11-04 11:12:09] production.DEBUG: isReadyForFileStep("define-roles")
[2024-11-04 11:12:09] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:12:09] production.DEBUG: storeArray: Stored 1210 bytes in file "32090b0416c63b2659fc3f0a24cfd31df2f8582304b617647db7abd4b89b98c1"
[2024-11-04 11:12:09] production.DEBUG: Old configuration was stored under key "".
[2024-11-04 11:12:09] production.DEBUG: New configuration is stored under key "32090b0416c63b2659fc3f0a24cfd31df2f8582304b617647db7abd4b89b98c1".
10.10.60.10 - - [04/Nov/2024:11:12:09 -0600] "POST /import/roles HTTP/1.1" 302 1589 "http://url:8080/import/roles" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"
[2024-11-04 11:12:09] production.DEBUG: isReadyForFileStep("conversion")
[2024-11-04 11:12:09] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:12:09] production.DEBUG: Will now verify configuration content.
[2024-11-04 11:12:09] production.DEBUG: Pressing "back" will send you to mapping.
[2024-11-04 11:12:09] production.DEBUG: Will redirect to submission after conversion.
[2024-11-04 11:12:09] production.DEBUG: Create CSV routine manager.
[2024-11-04 11:12:09] production.DEBUG: Going to generate conversion routine identifier.
[2024-11-04 11:12:09] production.DEBUG: Attempt #1 results in "conversion-j6YrL21Ov44c"
[2024-11-04 11:12:09] production.INFO: Job identifier is "conversion-j6YrL21Ov44c"
[2024-11-04 11:12:09] production.DEBUG: Conversion routine manager identifier is "conversion-j6YrL21Ov44c"
[2024-11-04 11:12:09] production.DEBUG: Stored "conversion-j6YrL21Ov44c" under "conversion_job_id"
10.10.60.10 - - [04/Nov/2024:11:12:09 -0600] "GET /import/convert HTTP/1.1" 200 3952 "http://url:8080/import/roles" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"

[2024-11-04 11:12:33] production.DEBUG: isReadyForFileStep("conversion")
[2024-11-04 11:12:33] production.DEBUG: isReadyForFileStep: Return true
[2024-11-04 11:12:33] production.DEBUG: Now at App\Http\Controllers\Import\ConversionController::status(conversion-j6YrL21Ov44c)
[2024-11-04 11:12:33] production.DEBUG: Now in startOrFindConversion(conversion-j6YrL21Ov44c)
[2024-11-04 11:12:33] production.DEBUG: Conversion status is "conv_errored"
10.10.60.10 - - [04/Nov/2024:11:12:33 -0600] "GET /import/convert/status?identifier=conversion-j6YrL21Ov44c HTTP/1.1" 200 1193 "http://url:8080/import/convert" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36"

JC5 · 2024-11-05T06:37:58Z

JC5
Nov 5, 2024
Maintainer

Looking at this error:

 [2024-11-04 11:10:00] production.DEBUG: DOMDocument::loadXML(): Start tag expected, '<' not found in Entity, line: 1

It looks like your file is invalid XML. What are you trying to import, exactly?

0 replies

mlause · 2024-11-05T06:42:45Z

mlause
Nov 5, 2024
Author

It is a csv file that I downloaded from my bank like I always do. To rule out corruption, I copied the data to a new file, copying and pasting as values. I received the same error.

1 reply

JC5 Nov 5, 2024
Maintainer

Mmm, sorry. I see no real errors in the logs, I'm not sure which part is breaking. Is there anything in the browser console?

mlause · 2024-11-06T03:51:00Z

mlause
Nov 6, 2024
Author

I tried another bank file, and it worked. I’ll redownload the other bank file and start over.

0 replies

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

Firefly III

Data importer The conversion could not be started, or failed due to an error. Please check the log files. Sorry about this :( #9426

{{title}}

Replies: 3 comments 1 reply

{{title}}

{{title}}

{{editor}}'s edit

{{editor}}'s edit

{{title}}

{{title}}

Select a reply

Firefly III

Data importer The conversion could not be started, or failed due to an error. Please check the log files. Sorry about this :( #9426

mlause Nov 4, 2024

Replies: 3 comments · 1 reply

JC5 Nov 5, 2024 Maintainer

mlause Nov 5, 2024 Author

JC5 Nov 5, 2024 Maintainer

mlause Nov 6, 2024 Author

mlause
Nov 4, 2024

Replies: 3 comments 1 reply

JC5
Nov 5, 2024
Maintainer

mlause
Nov 5, 2024
Author

JC5 Nov 5, 2024
Maintainer

mlause
Nov 6, 2024
Author