search

IBM / aspera-cli

IBM Aspera CLI
Apache License 2.0
76 stars 17 forks source link

After changing the permissions of shares in asper shares, it shows an error called Insufficient permissions #159

Open blogsook opened 1 month ago

blogsook commented 1 month ago

Hello.

Even if you remove the permissions of the shares from Aspera Shares, reauthorize the "mkdir" again, and start all the Background Jobs. It looks like ascli doesn't have the right permissions.

# ascli shares admin user local list --url='https://12.xxx.xxx.44:443' --username='admin' --password='🔑' --insecure=yes
WARNING: Ignoring certificate for: https://12.xxx.xxx.44:443. Do not deactivate certificate verification in production.
╭────┬──────────┬────────────┬───────────┬────────────────────╮
│ id │ username │ first_name │ last_name │ email              │
╞════╪══════════╪════════════╪═══════════╪════════════════════╡
│ 1  │ admin    │ <null>     │ <null>    │ aspera@example.com │
│ 2  │ test     │ test       │ test      │ edsffe@errere.net  │
│ 3  │ K SY     │ mongta     │ test      │ aaa@aaa            │
╰────┴──────────┴────────────┴───────────┴────────────────────╯

# ascli shares admin user all share_permissions 2 show 1 --url='https://12.xxx.xxx.44:443' --username='admin' --password='🔑' --insecure=yes
WARNING: Ignoring certificate for: https://12.xxx.xxx.44:443. Do not deactivate certificate verification in production.
╭─────────────────────────────────┬───────────────────────────╮
│ key                             │ value                     │
╞═════════════════════════════════╪═══════════════════════════╡
│ browse_permission               │ true                      │
│ content_availability_permission │ false                     │
│ created_at                      │ 2024-07-18T14:19:44+09:00 │
│ delete_permission               │ true                      │
│ download_permission             │ true                      │
│ id                              │ 2                         │
│ last_viewed_at                  │ <null>                    │
│ last_viewed_comments_at         │ <null>                    │
│ manage_permission               │ false                     │
│ mkdir_permission                │ true                      │
│ rename_permission               │ false                     │
│ share_id                        │ 1                         │
│ updated_at                      │ 2024-09-12T11:20:02+09:00 │
│ upload_permission               │ true                      │
│ user_id                         │ 2                         │
╰─────────────────────────────────┴───────────────────────────╯

root@secftptr4:/> ascli shares files mkdir '/share1/0912' --url='https://12.xxx.xxx.44:443' --username='test' --password='🔑' --insecure=yes --log-level=debug | tee ascli_log.txt
D, [2024-09-12T11:42:20.501627 #3925246] DEBUG -- : env={}
D, [2024-09-12T11:42:20.501728 #3925246] DEBUG -- : add_cmd_line_options:commands/arguments=["shares", "files", "mkdir", "/share1/0912"],options=["--url=https://12.xxx.xxx.44:443", "--username=test", "--password=🔑
D, [2024-09-12T11:42:20.501926 #3925246] DEBUG -- : declare: interactive: accessor
D, [2024-09-12T11:42:20.501977 #3925246] DEBUG -- : set attr obj interactive (#<Aspera::Cli::Manager:0x00007f7b7036ee38>,ask_missing_mandatory)
D, [2024-09-12T11:42:20.502027 #3925246] DEBUG -- : AttrAccessor: interactive: Aspera::Cli::Manager.ask_missing_mandatory: writer=true
D, [2024-09-12T11:42:20.502078 #3925246] DEBUG -- : (accessor) get interactive=false
D, [2024-09-12T11:42:20.502231 #3925246] DEBUG -- : on_args=["Use interactive input of missing params: [no], yes", "--interactive=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.502292 #3925246] DEBUG -- : declare: ask_options: accessor
D, [2024-09-12T11:42:20.502328 #3925246] DEBUG -- : set attr obj ask_options (#<Aspera::Cli::Manager:0x00007f7b7036ee38>,ask_missing_optional)
D, [2024-09-12T11:42:20.502367 #3925246] DEBUG -- : AttrAccessor: ask_options: Aspera::Cli::Manager.ask_missing_optional: writer=true
D, [2024-09-12T11:42:20.502407 #3925246] DEBUG -- : (accessor) get ask_options=false
D, [2024-09-12T11:42:20.502501 #3925246] DEBUG -- : on_args=["Ask even optional options: [no], yes", "--ask-options=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.502557 #3925246] DEBUG -- : declare: struct_parser: value
D, [2024-09-12T11:42:20.502588 #3925246] DEBUG -- : (value) get struct_parser=
D, [2024-09-12T11:42:20.502670 #3925246] DEBUG -- : on_args=["Default parser when expected value is a struct: json, ruby", "--struct-parser=ENUM", [:json, :ruby]]
D, [2024-09-12T11:42:20.502736 #3925246] DEBUG -- : declare: format: accessor
D, [2024-09-12T11:42:20.502772 #3925246] DEBUG -- : set attr obj format (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.502812 #3925246] DEBUG -- : AttrAccessor: format: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.502872 #3925246] DEBUG -- : (accessor/default) set format=table
D, [2024-09-12T11:42:20.502912 #3925246] DEBUG -- : (accessor) get format=table
D, [2024-09-12T11:42:20.503115 #3925246] DEBUG -- : on_args=["Output format: text, nagios, ruby, json, jsonpp, yaml, [table], csv, image", "--format=ENUM", [:text, :nagios, :ruby, :json, :jsonpp, :yaml, :table, :csv, :image]]
D, [2024-09-12T11:42:20.503208 #3925246] DEBUG -- : declare: output: accessor
D, [2024-09-12T11:42:20.503253 #3925246] DEBUG -- : set attr obj output (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.503291 #3925246] DEBUG -- : AttrAccessor: output: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.503370 #3925246] DEBUG -- : on_args=["Destination for results (String)", "--output=VALUE"]
D, [2024-09-12T11:42:20.503419 #3925246] DEBUG -- : declare: display: accessor
D, [2024-09-12T11:42:20.503451 #3925246] DEBUG -- : set attr obj display (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.503487 #3925246] DEBUG -- : AttrAccessor: display: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.503524 #3925246] DEBUG -- : (accessor/default) set display=info
D, [2024-09-12T11:42:20.503555 #3925246] DEBUG -- : (accessor) get display=info
D, [2024-09-12T11:42:20.503639 #3925246] DEBUG -- : on_args=["Output only some information: [info], data, error", "--display=ENUM", [:info, :data, :error]]
D, [2024-09-12T11:42:20.503707 #3925246] DEBUG -- : declare: fields: accessor
D, [2024-09-12T11:42:20.503744 #3925246] DEBUG -- : set attr obj fields (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.503782 #3925246] DEBUG -- : AttrAccessor: fields: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.503872 #3925246] DEBUG -- : (accessor/default) set fields=DEF
D, [2024-09-12T11:42:20.503957 #3925246] DEBUG -- : on_args=["Comma separated list of: fields, or ALL, or DEF (String, Array, Regexp, Proc)", "--fields=VALUE"]
D, [2024-09-12T11:42:20.504020 #3925246] DEBUG -- : declare: select: accessor
D, [2024-09-12T11:42:20.504057 #3925246] DEBUG -- : set attr obj select (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.504095 #3925246] DEBUG -- : AttrAccessor: select: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.504185 #3925246] DEBUG -- : on_args=["Select only some items in lists: column, value (Hash, Proc)", "--select=VALUE"]
D, [2024-09-12T11:42:20.504246 #3925246] DEBUG -- : declare: table_style: accessor
D, [2024-09-12T11:42:20.504283 #3925246] DEBUG -- : set attr obj table_style (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.504319 #3925246] DEBUG -- : AttrAccessor: table_style: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.504361 #3925246] DEBUG -- : (accessor/default) set table_style={}
D, [2024-09-12T11:42:20.504440 #3925246] DEBUG -- : on_args=["Table display style (Hash)", "--table-style=VALUE"]
D, [2024-09-12T11:42:20.504487 #3925246] DEBUG -- : declare: flat_hash: accessor
D, [2024-09-12T11:42:20.504521 #3925246] DEBUG -- : set attr obj flat_hash (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.504556 #3925246] DEBUG -- : AttrAccessor: flat_hash: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.504595 #3925246] DEBUG -- : (accessor/default) set flat_hash=true
D, [2024-09-12T11:42:20.504630 #3925246] DEBUG -- : (accessor/default) set flat_hash=true
D, [2024-09-12T11:42:20.504658 #3925246] DEBUG -- : (accessor) get flat_hash=true
D, [2024-09-12T11:42:20.504755 #3925246] DEBUG -- : on_args=["Display deep values as additional keys: no, [yes]", "--flat-hash=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.504812 #3925246] DEBUG -- : declare: transpose_single: accessor
D, [2024-09-12T11:42:20.504847 #3925246] DEBUG -- : set attr obj transpose_single (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.504883 #3925246] DEBUG -- : AttrAccessor: transpose_single: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.504922 #3925246] DEBUG -- : (accessor/default) set transpose_single=true
D, [2024-09-12T11:42:20.504953 #3925246] DEBUG -- : (accessor/default) set transpose_single=true
D, [2024-09-12T11:42:20.504981 #3925246] DEBUG -- : (accessor) get transpose_single=true
D, [2024-09-12T11:42:20.505074 #3925246] DEBUG -- : on_args=["Single object fields output vertically: no, [yes]", "--transpose-single=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.505131 #3925246] DEBUG -- : declare: show_secrets: accessor
D, [2024-09-12T11:42:20.505166 #3925246] DEBUG -- : set attr obj show_secrets (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.505219 #3925246] DEBUG -- : AttrAccessor: show_secrets: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.505259 #3925246] DEBUG -- : (accessor/default) set show_secrets=false
D, [2024-09-12T11:42:20.505291 #3925246] DEBUG -- : (accessor/default) set show_secrets=false
D, [2024-09-12T11:42:20.505319 #3925246] DEBUG -- : (accessor) get show_secrets=false
D, [2024-09-12T11:42:20.505415 #3925246] DEBUG -- : on_args=["Show secrets on command output: [no], yes", "--show-secrets=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.505478 #3925246] DEBUG -- : declare: image: accessor
D, [2024-09-12T11:42:20.505512 #3925246] DEBUG -- : set attr obj image (#<Aspera::Cli::Formatter:0x00007f7b7036ef28>,option_handler)
D, [2024-09-12T11:42:20.505547 #3925246] DEBUG -- : AttrAccessor: image: Aspera::Cli::Formatter.option_handler: writer=false
D, [2024-09-12T11:42:20.505584 #3925246] DEBUG -- : (accessor/default) set image={}
D, [2024-09-12T11:42:20.505671 #3925246] DEBUG -- : on_args=["Options for image display (Hash)", "--image=VALUE"]
D, [2024-09-12T11:42:20.505712 #3925246] DEBUG -- : (value) get struct_parser=
D, [2024-09-12T11:42:20.505740 #3925246] DEBUG -- : setting default decoder to  (NilClass)
D, [2024-09-12T11:42:20.505768 #3925246] DEBUG -- : declare_global_options
D, [2024-09-12T11:42:20.505802 #3925246] DEBUG -- : declare: help: value
D, [2024-09-12T11:42:20.505885 #3925246] DEBUG -- : on_args=["Show this message", "--help", "-h"]
D, [2024-09-12T11:42:20.505931 #3925246] DEBUG -- : declare: bash_comp: value
D, [2024-09-12T11:42:20.506003 #3925246] DEBUG -- : on_args=["Generate bash completion for command", "--bash-comp"]
D, [2024-09-12T11:42:20.506050 #3925246] DEBUG -- : declare: show_config: value
D, [2024-09-12T11:42:20.506120 #3925246] DEBUG -- : on_args=["Display parameters used for the provided action", "--show-config"]
D, [2024-09-12T11:42:20.506168 #3925246] DEBUG -- : declare: version: value
D, [2024-09-12T11:42:20.506377 #3925246] DEBUG -- : on_args=["Display version", "--version", "-v"]
D, [2024-09-12T11:42:20.506446 #3925246] DEBUG -- : declare: ui: accessor
D, [2024-09-12T11:42:20.506482 #3925246] DEBUG -- : set attr obj ui (#<Aspera::Environment:0x00007f7b703066a8>,url_method)
D, [2024-09-12T11:42:20.506519 #3925246] DEBUG -- : AttrAccessor: ui: Aspera::Environment.url_method: writer=true
D, [2024-09-12T11:42:20.506556 #3925246] DEBUG -- : (accessor/default) set ui=text
D, [2024-09-12T11:42:20.506587 #3925246] DEBUG -- : (accessor) get ui=text
D, [2024-09-12T11:42:20.506679 #3925246] DEBUG -- : on_args=["Method to start browser: [text], graphical", "--ui=ENUM", [:text, :graphical]]
D, [2024-09-12T11:42:20.506751 #3925246] DEBUG -- : declare: log_level: accessor
D, [2024-09-12T11:42:20.506787 #3925246] DEBUG -- : set attr obj log_level (#<Aspera::Log:0x00007f7b78d381c8>,level)
D, [2024-09-12T11:42:20.506821 #3925246] DEBUG -- : AttrAccessor: log_level: Aspera::Log.level: writer=true
D, [2024-09-12T11:42:20.506865 #3925246] DEBUG -- : (accessor) get log_level=debug
D, [2024-09-12T11:42:20.506968 #3925246] DEBUG -- : on_args=["Log level: trace2, trace1, [debug], info, warn, error, fatal, unknown", "--log-level=ENUM", [:trace2, :trace1, :debug, :info, :warn, :error, :fatal, :unknown]]
D, [2024-09-12T11:42:20.507032 #3925246] DEBUG -- : declare: logger: accessor
D, [2024-09-12T11:42:20.507065 #3925246] DEBUG -- : set attr obj logger (#<Aspera::Log:0x00007f7b78d381c8>,logger_type)
D, [2024-09-12T11:42:20.507097 #3925246] DEBUG -- : AttrAccessor: logger: Aspera::Log.logger_type: writer=true
D, [2024-09-12T11:42:20.507130 #3925246] DEBUG -- : (accessor) get logger=stderr
D, [2024-09-12T11:42:20.507238 #3925246] DEBUG -- : on_args=["Logging method: [stderr], stdout, syslog", "--logger=ENUM", [:stderr, :stdout, :syslog]]
D, [2024-09-12T11:42:20.507302 #3925246] DEBUG -- : declare: lock_port: value
D, [2024-09-12T11:42:20.507388 #3925246] DEBUG -- : on_args=["Prevent dual execution of a command, e.g. in cron (Integer)", "--lock-port=VALUE", Integer]
D, [2024-09-12T11:42:20.507442 #3925246] DEBUG -- : declare: once_only: value
D, [2024-09-12T11:42:20.507471 #3925246] DEBUG -- : (value/default) set once_only=false
D, [2024-09-12T11:42:20.507498 #3925246] DEBUG -- : (value/default) set once_only=false
D, [2024-09-12T11:42:20.507521 #3925246] DEBUG -- : (value) get once_only=false
D, [2024-09-12T11:42:20.507617 #3925246] DEBUG -- : on_args=["Process only new items (some commands): [no], yes", "--once-only=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.507671 #3925246] DEBUG -- : declare: log_secrets: accessor
D, [2024-09-12T11:42:20.507705 #3925246] DEBUG -- : set attr obj log_secrets (Aspera::SecretHider,log_secrets)
D, [2024-09-12T11:42:20.507739 #3925246] DEBUG -- : AttrAccessor: log_secrets: Class.log_secrets: writer=true
D, [2024-09-12T11:42:20.507776 #3925246] DEBUG -- : (accessor) get log_secrets=false
D, [2024-09-12T11:42:20.507876 #3925246] DEBUG -- : on_args=["Show passwords in logs: [no], yes", "--log-secrets=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.507931 #3925246] DEBUG -- : declare: clean_temp: accessor
D, [2024-09-12T11:42:20.507967 #3925246] DEBUG -- : set attr obj clean_temp (#<Aspera::TempFileManager:0x00007f7b7035e998>,cleanup_on_exit)
D, [2024-09-12T11:42:20.508006 #3925246] DEBUG -- : AttrAccessor: clean_temp: Aspera::TempFileManager.cleanup_on_exit: writer=true
D, [2024-09-12T11:42:20.508046 #3925246] DEBUG -- : (accessor) get clean_temp=true
D, [2024-09-12T11:42:20.508147 #3925246] DEBUG -- : on_args=["Cleanup temporary files on exit: no, [yes]", "--clean-temp=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.508218 #3925246] DEBUG -- : declare: pid_file: value
D, [2024-09-12T11:42:20.508300 #3925246] DEBUG -- : on_args=["Write process identifier to file, delete on exit (String)", "--pid-file=VALUE"]
D, [2024-09-12T11:42:20.508340 #3925246] DEBUG -- : parse_options!
D, [2024-09-12T11:42:20.508363 #3925246] DEBUG -- : consume_option_pairs: set
D, [2024-09-12T11:42:20.508385 #3925246] DEBUG -- : consume_option_pairs: env
D, [2024-09-12T11:42:20.508405 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.508724 #3925246] DEBUG -- : InvalidOption invalid option: --url=https://12.xxx.xxx.44:443
D, [2024-09-12T11:42:20.508867 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.509209 #3925246] DEBUG -- : InvalidOption invalid option: --username=test
D, [2024-09-12T11:42:20.509248 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.509565 #3925246] DEBUG -- : InvalidOption invalid option: --password=🔑
D, [2024-09-12T11:42:20.509607 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.509927 #3925246] DEBUG -- : InvalidOption invalid option: --insecure=yes
D, [2024-09-12T11:42:20.509963 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.510135 #3925246] DEBUG -- : (accessor/cmdline) set log_level=debug
D, [2024-09-12T11:42:20.510188 #3925246] DEBUG -- : After parse
D, [2024-09-12T11:42:20.510220 #3925246] DEBUG -- : remains: ["--url=https://12.xxx.xxx.44:443", "--username=test", "--password=🔑
D, [2024-09-12T11:42:20.510414 #3925246] DEBUG -- : declare: home: accessor
D, [2024-09-12T11:42:20.510457 #3925246] DEBUG -- : set attr obj home (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,main_folder)
D, [2024-09-12T11:42:20.510498 #3925246] DEBUG -- : AttrAccessor: home: Aspera::Cli::Plugins::Config.main_folder: writer=true
D, [2024-09-12T11:42:20.510577 #3925246] DEBUG -- : (accessor/default) set home=/.aspera/ascli
D, [2024-09-12T11:42:20.510672 #3925246] DEBUG -- : on_args=["Home folder for tool (String)", "--home=VALUE"]
D, [2024-09-12T11:42:20.510705 #3925246] DEBUG -- : parse_options!
D, [2024-09-12T11:42:20.510725 #3925246] DEBUG -- : consume_option_pairs: set
D, [2024-09-12T11:42:20.510745 #3925246] DEBUG -- : consume_option_pairs: env
D, [2024-09-12T11:42:20.510764 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.511008 #3925246] DEBUG -- : InvalidOption invalid option: --url=https://12.xxx.xxx.44:443
D, [2024-09-12T11:42:20.511045 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.516593 #3925246] DEBUG -- : InvalidOption invalid option: --username=test
D, [2024-09-12T11:42:20.516641 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.521831 #3925246] DEBUG -- : InvalidOption invalid option: --password=🔑
D, [2024-09-12T11:42:20.521883 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.526158 #3925246] DEBUG -- : InvalidOption invalid option: --insecure=yes
D, [2024-09-12T11:42:20.526209 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.526246 #3925246] DEBUG -- : After parse
D, [2024-09-12T11:42:20.526275 #3925246] DEBUG -- : remains: ["--url=https://12.xxx.xxx.44:443", "--username=test", "--password=🔑
D, [2024-09-12T11:42:20.526320 #3925246] DEBUG -- : ascli folder: /.aspera/ascli
D, [2024-09-12T11:42:20.526352 #3925246] DEBUG -- : persistency folder: /.aspera/ascli/persist_store
D, [2024-09-12T11:42:20.526426 #3925246] DEBUG -- : declare: config_file: accessor
D, [2024-09-12T11:42:20.526467 #3925246] DEBUG -- : set attr obj config_file (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_config_file)
D, [2024-09-12T11:42:20.526508 #3925246] DEBUG -- : AttrAccessor: config_file: Aspera::Cli::Plugins::Config.option_config_file: writer=true
D, [2024-09-12T11:42:20.526595 #3925246] DEBUG -- : (accessor/default) set config_file=/.aspera/ascli/config.yaml
D, [2024-09-12T11:42:20.526701 #3925246] DEBUG -- : on_args=["Path to YAML file with preset configuration", "--config-file=VALUE"]
D, [2024-09-12T11:42:20.526741 #3925246] DEBUG -- : parse_options!
D, [2024-09-12T11:42:20.526763 #3925246] DEBUG -- : consume_option_pairs: set
D, [2024-09-12T11:42:20.526784 #3925246] DEBUG -- : consume_option_pairs: env
D, [2024-09-12T11:42:20.526804 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.527067 #3925246] DEBUG -- : InvalidOption invalid option: --url=https://12.xxx.xxx.44:443
D, [2024-09-12T11:42:20.527106 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.527460 #3925246] DEBUG -- : InvalidOption invalid option: --username=test
D, [2024-09-12T11:42:20.527497 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.527832 #3925246] DEBUG -- : InvalidOption invalid option: --password=🔑
D, [2024-09-12T11:42:20.527874 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.528222 #3925246] DEBUG -- : InvalidOption invalid option: --insecure=yes
D, [2024-09-12T11:42:20.528259 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.528290 #3925246] DEBUG -- : After parse
D, [2024-09-12T11:42:20.528317 #3925246] DEBUG -- : remains: ["--url=https://12.xxx.xxx.44:443", "--username=test", "--password=🔑
D, [2024-09-12T11:42:20.528364 #3925246] DEBUG -- : config file is: /.aspera/ascli/config.yaml
D, [2024-09-12T11:42:20.528403 #3925246] DEBUG -- : loading /.aspera/ascli/config.yaml
D, [2024-09-12T11:42:20.528770 #3925246] DEBUG -- : Available_presets (json)=
{
  "config": {
    "version": "4.18.1"
  }
}
D, [2024-09-12T11:42:20.528820 #3925246] DEBUG -- : conf version: 4.18.1
D, [2024-09-12T11:42:20.528851 #3925246] DEBUG -- : setting handler for preset
D, [2024-09-12T11:42:20.528877 #3925246] DEBUG -- : setting handler for vault
D, [2024-09-12T11:42:20.528904 #3925246] DEBUG -- : add_plugin_default_preset:config:
D, [2024-09-12T11:42:20.528940 #3925246] DEBUG -- : declare: secret: 🔑
D, [2024-09-12T11:42:20.529035 #3925246] DEBUG -- : on_args=["Secret for access keys", "--secret=🔑
D, [2024-09-12T11:42:20.529093 #3925246] DEBUG -- : declare: vault: value
D, [2024-09-12T11:42:20.529183 #3925246] DEBUG -- : on_args=["Vault for secrets (Hash)", "--vault=VALUE"]
D, [2024-09-12T11:42:20.529231 #3925246] DEBUG -- : declare: vault_password: 🔑
D, [2024-09-12T11:42:20.529322 #3925246] DEBUG -- : on_args=["Vault password", "--vault-password=🔑
D, [2024-09-12T11:42:20.529361 #3925246] DEBUG -- : parse_options!
D, [2024-09-12T11:42:20.529380 #3925246] DEBUG -- : consume_option_pairs: set
D, [2024-09-12T11:42:20.529400 #3925246] DEBUG -- : consume_option_pairs: env
D, [2024-09-12T11:42:20.529419 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.529684 #3925246] DEBUG -- : InvalidOption invalid option: --url=https://12.xxx.xxx.44:443
D, [2024-09-12T11:42:20.529723 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.530081 #3925246] DEBUG -- : InvalidOption invalid option: --username=test
D, [2024-09-12T11:42:20.530118 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.530485 #3925246] DEBUG -- : InvalidOption invalid option: --password=🔑
D, [2024-09-12T11:42:20.530529 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.531013 #3925246] DEBUG -- : InvalidOption invalid option: --insecure=yes
D, [2024-09-12T11:42:20.531052 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.531082 #3925246] DEBUG -- : After parse
D, [2024-09-12T11:42:20.531108 #3925246] DEBUG -- : remains: ["--url=https://12.xxx.xxx.44:443", "--username=test", "--password=🔑
D, [2024-09-12T11:42:20.531181 #3925246] DEBUG -- : declare: query: value
D, [2024-09-12T11:42:20.531310 #3925246] DEBUG -- : on_args=["Additional filter for for some commands (list/delete) (Hash)", "--query=VALUE"]
D, [2024-09-12T11:42:20.531371 #3925246] DEBUG -- : declare: value: value
D, [2024-09-12T11:42:20.531457 #3925246] DEBUG -- : on_args=["Value for create, update, list filter (Hash) (deprecated: (4.14) Use positional value for create/modify or option: query for list/delete)", "--value=VALUE"]
D, [2024-09-12T11:42:20.531520 #3925246] DEBUG -- : declare: property: value
D, [2024-09-12T11:42:20.531609 #3925246] DEBUG -- : on_args=["Name of property to set (modify operation)", "--property=VALUE"]
D, [2024-09-12T11:42:20.531658 #3925246] DEBUG -- : declare: bulk: value
D, [2024-09-12T11:42:20.531686 #3925246] DEBUG -- : (value/default) set bulk=no
D, [2024-09-12T11:42:20.531716 #3925246] DEBUG -- : (value/default) set bulk=false
D, [2024-09-12T11:42:20.531740 #3925246] DEBUG -- : (value) get bulk=false
D, [2024-09-12T11:42:20.531854 #3925246] DEBUG -- : on_args=["Bulk operation (only some): [no], yes", "--bulk=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.531906 #3925246] DEBUG -- : declare: bfail: value
D, [2024-09-12T11:42:20.531935 #3925246] DEBUG -- : (value/default) set bfail=yes
D, [2024-09-12T11:42:20.531962 #3925246] DEBUG -- : (value/default) set bfail=true
D, [2024-09-12T11:42:20.531985 #3925246] DEBUG -- : (value) get bfail=true
D, [2024-09-12T11:42:20.532088 #3925246] DEBUG -- : on_args=["Bulk operation error handling: no, [yes]", "--bfail=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.532142 #3925246] DEBUG -- : declare: no_default: value
D, [2024-09-12T11:42:20.532263 #3925246] DEBUG -- : on_args=["Do not load default configuration for plugin", "--no-default", "-N"]
D, [2024-09-12T11:42:20.532359 #3925246] DEBUG -- : declare: preset: accessor
D, [2024-09-12T11:42:20.532400 #3925246] DEBUG -- : set attr obj preset (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_preset)
D, [2024-09-12T11:42:20.532440 #3925246] DEBUG -- : AttrAccessor: preset: Aspera::Cli::Plugins::Config.option_preset: writer=true
D, [2024-09-12T11:42:20.532551 #3925246] DEBUG -- : on_args=["Load the named option preset from current config file", "--preset=VALUE", "-PVALUE"]
D, [2024-09-12T11:42:20.532608 #3925246] DEBUG -- : declare: version_check_days: value
D, [2024-09-12T11:42:20.532643 #3925246] DEBUG -- : (value/default) set version_check_days=7
D, [2024-09-12T11:42:20.532745 #3925246] DEBUG -- : on_args=["Period in days to check new version (zero to disable)", "--version-check-days=VALUE", Integer]
D, [2024-09-12T11:42:20.532802 #3925246] DEBUG -- : declare: plugin_folder: accessor
D, [2024-09-12T11:42:20.532837 #3925246] DEBUG -- : set attr obj plugin_folder (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_plugin_folder)
D, [2024-09-12T11:42:20.532875 #3925246] DEBUG -- : AttrAccessor: plugin_folder: Aspera::Cli::Plugins::Config.option_plugin_folder: writer=true
D, [2024-09-12T11:42:20.532976 #3925246] DEBUG -- : on_args=["Folder where to find additional plugins", "--plugin-folder=VALUE"]
D, [2024-09-12T11:42:20.533025 #3925246] DEBUG -- : declare: override: value
D, [2024-09-12T11:42:20.533055 #3925246] DEBUG -- : (value/default) set override=no
D, [2024-09-12T11:42:20.533084 #3925246] DEBUG -- : (value/default) set override=false
D, [2024-09-12T11:42:20.533109 #3925246] DEBUG -- : (value) get override=false
D, [2024-09-12T11:42:20.533233 #3925246] DEBUG -- : on_args=["Wizard: override existing value: [no], yes", "--override=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.533289 #3925246] DEBUG -- : declare: default: value
D, [2024-09-12T11:42:20.533319 #3925246] DEBUG -- : (value/default) set default=true
D, [2024-09-12T11:42:20.533348 #3925246] DEBUG -- : (value/default) set default=true
D, [2024-09-12T11:42:20.533372 #3925246] DEBUG -- : (value) get default=true
D, [2024-09-12T11:42:20.533486 #3925246] DEBUG -- : on_args=["Wizard: set as default configuration for specified plugin (also: update): no, [yes]", "--default=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.533548 #3925246] DEBUG -- : declare: test_mode: value
D, [2024-09-12T11:42:20.533579 #3925246] DEBUG -- : (value/default) set test_mode=false
D, [2024-09-12T11:42:20.533608 #3925246] DEBUG -- : (value/default) set test_mode=false
D, [2024-09-12T11:42:20.533633 #3925246] DEBUG -- : (value) get test_mode=false
D, [2024-09-12T11:42:20.533749 #3925246] DEBUG -- : on_args=["Wizard: skip private key check step: [no], yes", "--test-mode=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.533807 #3925246] DEBUG -- : declare: key_path: value
D, [2024-09-12T11:42:20.533898 #3925246] DEBUG -- : on_args=["Wizard: path to private key for JWT", "--key-path=VALUE"]
D, [2024-09-12T11:42:20.534077 #3925246] DEBUG -- : declare: ascp_path: accessor
D, [2024-09-12T11:42:20.534119 #3925246] DEBUG -- : set attr obj ascp_path (#<Aspera::Ascp::Installation:0x00007f7b771bfd60>,ascp_path)
D, [2024-09-12T11:42:20.534161 #3925246] DEBUG -- : AttrAccessor: ascp_path: Aspera::Ascp::Installation.ascp_path: writer=true
D, [2024-09-12T11:42:20.534308 #3925246] DEBUG -- : on_args=["Path to ascp", "--ascp-path=VALUE"]
D, [2024-09-12T11:42:20.534358 #3925246] DEBUG -- : declare: use_product: accessor
D, [2024-09-12T11:42:20.534392 #3925246] DEBUG -- : set attr obj use_product (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_use_product)
D, [2024-09-12T11:42:20.534430 #3925246] DEBUG -- : AttrAccessor: use_product: Aspera::Cli::Plugins::Config.option_use_product: writer=true
D, [2024-09-12T11:42:20.534533 #3925246] DEBUG -- : on_args=["Use ascp from specified product", "--use-product=VALUE"]
D, [2024-09-12T11:42:20.534583 #3925246] DEBUG -- : declare: sdk_url: value
D, [2024-09-12T11:42:20.534654 #3925246] DEBUG -- : (value/default) set sdk_url=https://ibm.biz/aspera_transfer_sdk
D, [2024-09-12T11:42:20.534758 #3925246] DEBUG -- : on_args=["URL to get SDK", "--sdk-url=VALUE"]
D, [2024-09-12T11:42:20.534805 #3925246] DEBUG -- : declare: sdk_folder: accessor
D, [2024-09-12T11:42:20.534839 #3925246] DEBUG -- : set attr obj sdk_folder (#<Aspera::Ascp::Installation:0x00007f7b771bfd60>,sdk_folder)
D, [2024-09-12T11:42:20.534877 #3925246] DEBUG -- : AttrAccessor: sdk_folder: Aspera::Ascp::Installation.sdk_folder: writer=true
D, [2024-09-12T11:42:20.534977 #3925246] DEBUG -- : on_args=["SDK folder path", "--sdk-folder=VALUE"]
D, [2024-09-12T11:42:20.535026 #3925246] DEBUG -- : declare: progress_bar: value
D, [2024-09-12T11:42:20.535057 #3925246] DEBUG -- : (value/default) set progress_bar=false
D, [2024-09-12T11:42:20.535086 #3925246] DEBUG -- : (value/default) set progress_bar=false
D, [2024-09-12T11:42:20.535110 #3925246] DEBUG -- : (value) get progress_bar=false
D, [2024-09-12T11:42:20.535251 #3925246] DEBUG -- : on_args=["Display progress bar: [no], yes", "--progress-bar=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.535313 #3925246] DEBUG -- : declare: smtp: value
D, [2024-09-12T11:42:20.535411 #3925246] DEBUG -- : on_args=["SMTP configuration (Hash)", "--smtp=VALUE"]
D, [2024-09-12T11:42:20.535457 #3925246] DEBUG -- : declare: notify_to: value
D, [2024-09-12T11:42:20.535554 #3925246] DEBUG -- : on_args=["Email recipient for notification of transfers", "--notify-to=VALUE"]
D, [2024-09-12T11:42:20.535862 #3925246] DEBUG -- : declare: notify_template: value
D, [2024-09-12T11:42:20.535962 #3925246] DEBUG -- : on_args=["Email ERB template for notification of transfers", "--notify-template=VALUE"]
D, [2024-09-12T11:42:20.536014 #3925246] DEBUG -- : declare: insecure: accessor
D, [2024-09-12T11:42:20.536049 #3925246] DEBUG -- : set attr obj insecure (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_insecure)
D, [2024-09-12T11:42:20.536088 #3925246] DEBUG -- : AttrAccessor: insecure: Aspera::Cli::Plugins::Config.option_insecure: writer=true
D, [2024-09-12T11:42:20.536128 #3925246] DEBUG -- : (accessor/default) set insecure=no
D, [2024-09-12T11:42:20.536160 #3925246] DEBUG -- : (accessor/default) set insecure=false
D, [2024-09-12T11:42:20.536201 #3925246] DEBUG -- : (accessor) get insecure=false
D, [2024-09-12T11:42:20.536327 #3925246] DEBUG -- : on_args=["Do not validate any HTTPS certificate: [no], yes", "--insecure=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.536393 #3925246] DEBUG -- : declare: ignore_certificate: accessor
D, [2024-09-12T11:42:20.536431 #3925246] DEBUG -- : set attr obj ignore_certificate (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_ignore_cert_host_port)
D, [2024-09-12T11:42:20.536473 #3925246] DEBUG -- : AttrAccessor: ignore_certificate: Aspera::Cli::Plugins::Config.option_ignore_cert_host_port: writer=true
D, [2024-09-12T11:42:20.536589 #3925246] DEBUG -- : on_args=["Do not validate HTTPS certificate for these URLs (Array)", "--ignore-certificate=VALUE"]
D, [2024-09-12T11:42:20.536646 #3925246] DEBUG -- : declare: silent_insecure: accessor
D, [2024-09-12T11:42:20.536682 #3925246] DEBUG -- : set attr obj silent_insecure (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_warn_insecure_cert)
D, [2024-09-12T11:42:20.536722 #3925246] DEBUG -- : AttrAccessor: silent_insecure: Aspera::Cli::Plugins::Config.option_warn_insecure_cert: writer=true
D, [2024-09-12T11:42:20.536765 #3925246] DEBUG -- : (accessor/default) set silent_insecure=yes
D, [2024-09-12T11:42:20.536798 #3925246] DEBUG -- : (accessor/default) set silent_insecure=true
D, [2024-09-12T11:42:20.536827 #3925246] DEBUG -- : (accessor) get silent_insecure=true
D, [2024-09-12T11:42:20.536952 #3925246] DEBUG -- : on_args=["Issue a warning if certificate is ignored: no, [yes]", "--silent-insecure=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.537019 #3925246] DEBUG -- : declare: cert_stores: accessor
D, [2024-09-12T11:42:20.537055 #3925246] DEBUG -- : set attr obj cert_stores (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,trusted_cert_locations)
D, [2024-09-12T11:42:20.537094 #3925246] DEBUG -- : AttrAccessor: cert_stores: Aspera::Cli::Plugins::Config.trusted_cert_locations: writer=true
D, [2024-09-12T11:42:20.537215 #3925246] DEBUG -- : on_args=["List of folder with trusted certificates (Array, String)", "--cert-stores=VALUE"]
D, [2024-09-12T11:42:20.537277 #3925246] DEBUG -- : declare: http_options: accessor
D, [2024-09-12T11:42:20.537313 #3925246] DEBUG -- : set attr obj http_options (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_http_options)
D, [2024-09-12T11:42:20.537353 #3925246] DEBUG -- : AttrAccessor: http_options: Aspera::Cli::Plugins::Config.option_http_options: writer=true
D, [2024-09-12T11:42:20.537397 #3925246] DEBUG -- : (accessor/default) set http_options={}
D, [2024-09-12T11:42:20.537611 #3925246] DEBUG -- : on_args=["Options for HTTP/S socket (Hash)", "--http-options=VALUE"]
D, [2024-09-12T11:42:20.537671 #3925246] DEBUG -- : declare: http_proxy: accessor
D, [2024-09-12T11:42:20.537706 #3925246] DEBUG -- : set attr obj http_proxy (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_http_proxy)
D, [2024-09-12T11:42:20.537744 #3925246] DEBUG -- : AttrAccessor: http_proxy: Aspera::Cli::Plugins::Config.option_http_proxy: writer=true
D, [2024-09-12T11:42:20.537856 #3925246] DEBUG -- : on_args=["URL for HTTP proxy with optional credentials (String)", "--http-proxy=VALUE"]
D, [2024-09-12T11:42:20.537910 #3925246] DEBUG -- : declare: cache_tokens: accessor
D, [2024-09-12T11:42:20.537945 #3925246] DEBUG -- : set attr obj cache_tokens (#<Aspera::Cli::Plugins::Config:0x00007f7b702f1208>,option_cache_tokens)
D, [2024-09-12T11:42:20.537983 #3925246] DEBUG -- : AttrAccessor: cache_tokens: Aspera::Cli::Plugins::Config.option_cache_tokens: writer=true
D, [2024-09-12T11:42:20.538023 #3925246] DEBUG -- : (accessor) get cache_tokens=true
D, [2024-09-12T11:42:20.538149 #3925246] DEBUG -- : on_args=["Save and reuse OAuth tokens: no, [yes]", "--cache-tokens=ENUM", [:yes, true, :no, false]]
D, [2024-09-12T11:42:20.538211 #3925246] DEBUG -- : declare: fpac: value
D, [2024-09-12T11:42:20.538311 #3925246] DEBUG -- : on_args=["Proxy auto configuration script", "--fpac=VALUE"]
D, [2024-09-12T11:42:20.538365 #3925246] DEBUG -- : declare: proxy_credentials: value
D, [2024-09-12T11:42:20.538465 #3925246] DEBUG -- : on_args=["HTTP proxy credentials for fpac. Array: user,password 🔑
D, [2024-09-12T11:42:20.538512 #3925246] DEBUG -- : parse_options!
D, [2024-09-12T11:42:20.538534 #3925246] DEBUG -- : consume_option_pairs: set
D, [2024-09-12T11:42:20.538554 #3925246] DEBUG -- : consume_option_pairs: env
D, [2024-09-12T11:42:20.538573 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.538939 #3925246] DEBUG -- : InvalidOption invalid option: --url=https://12.xxx.xxx.44:443
D, [2024-09-12T11:42:20.538977 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.539537 #3925246] DEBUG -- : InvalidOption invalid option: --username=test
D, [2024-09-12T11:42:20.539575 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.540213 #3925246] DEBUG -- : InvalidOption invalid option: --password=🔑
D, [2024-09-12T11:42:20.540258 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.540346 #3925246] DEBUG -- : (accessor/cmdline) set insecure=true
D, [2024-09-12T11:42:20.540385 #3925246] DEBUG -- : After parse
D, [2024-09-12T11:42:20.540412 #3925246] DEBUG -- : remains: ["--url=https://12.xxx.xxx.44:443", "--username=test", "--password=🔑
D, [2024-09-12T11:42:20.540456 #3925246] DEBUG -- : (value) get progress_bar=false
D, [2024-09-12T11:42:20.540490 #3925246] DEBUG -- : SDK folder is not set, checking default
D, [2024-09-12T11:42:20.540528 #3925246] DEBUG -- : checking: /.aspera/sdk
D, [2024-09-12T11:42:20.540558 #3925246] DEBUG -- : using: /.aspera/sdk
D, [2024-09-12T11:42:20.540582 #3925246] DEBUG -- : sdk_folder=/.aspera/sdk
D, [2024-09-12T11:42:20.540637 #3925246] DEBUG -- : (value) get fpac=
D, [2024-09-12T11:42:20.540823 #3925246] DEBUG -- : registering Aspera REST error handlers
D, [2024-09-12T11:42:20.540899 #3925246] DEBUG -- : declare: ts: accessor
D, [2024-09-12T11:42:20.540939 #3925246] DEBUG -- : set attr obj ts (#<Aspera::Cli::TransferAgent:0x00007f7b7033b678>,option_transfer_spec)
D, [2024-09-12T11:42:20.540980 #3925246] DEBUG -- : AttrAccessor: ts: Aspera::Cli::TransferAgent.option_transfer_spec: writer=true
D, [2024-09-12T11:42:20.541100 #3925246] DEBUG -- : on_args=["Override transfer spec values (Hash)", "--ts=VALUE"]
D, [2024-09-12T11:42:20.541151 #3925246] DEBUG -- : declare: to_folder: value
D, [2024-09-12T11:42:20.541260 #3925246] DEBUG -- : on_args=["Destination folder for transferred files", "--to-folder=VALUE"]
D, [2024-09-12T11:42:20.541313 #3925246] DEBUG -- : declare: sources: value
D, [2024-09-12T11:42:20.541415 #3925246] DEBUG -- : on_args=["How list of transferred files is provided (@args,@ts,Array)", "--sources=VALUE"]
D, [2024-09-12T11:42:20.541468 #3925246] DEBUG -- : declare: src_type: value
D, [2024-09-12T11:42:20.541499 #3925246] DEBUG -- : (value/default) set src_type=list
D, [2024-09-12T11:42:20.541526 #3925246] DEBUG -- : (value) get src_type=list
D, [2024-09-12T11:42:20.541645 #3925246] DEBUG -- : on_args=["Type of file list: [list], pair", "--src-type=ENUM", [:list, :pair]]
D, [2024-09-12T11:42:20.541708 #3925246] DEBUG -- : declare: transfer: value
D, [2024-09-12T11:42:20.541740 #3925246] DEBUG -- : (value/default) set transfer=direct
D, [2024-09-12T11:42:20.541767 #3925246] DEBUG -- : (value) get transfer=direct
D, [2024-09-12T11:42:20.541896 #3925246] DEBUG -- : on_args=["Type of transfer agent: alpha, connect, [direct], httpgw, node, trsdk", "--transfer=ENUM", [:alpha, :connect, :direct, :httpgw, :node, :trsdk]]
D, [2024-09-12T11:42:20.541967 #3925246] DEBUG -- : declare: transfer_info: accessor
D, [2024-09-12T11:42:20.542004 #3925246] DEBUG -- : set attr obj transfer_info (#<Aspera::Cli::TransferAgent:0x00007f7b7033b678>,transfer_info)
D, [2024-09-12T11:42:20.542043 #3925246] DEBUG -- : AttrAccessor: transfer_info: Aspera::Cli::TransferAgent.transfer_info: writer=true
D, [2024-09-12T11:42:20.542164 #3925246] DEBUG -- : on_args=["Parameters for transfer agent (Hash)", "--transfer-info=VALUE"]
D, [2024-09-12T11:42:20.542212 #3925246] DEBUG -- : parse_options!
D, [2024-09-12T11:42:20.542234 #3925246] DEBUG -- : consume_option_pairs: set
D, [2024-09-12T11:42:20.542256 #3925246] DEBUG -- : consume_option_pairs: env
D, [2024-09-12T11:42:20.542275 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.542758 #3925246] DEBUG -- : InvalidOption invalid option: --url=https://12.xxx.xxx.44:443
D, [2024-09-12T11:42:20.542798 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.543393 #3925246] DEBUG -- : InvalidOption invalid option: --username=test
D, [2024-09-12T11:42:20.543430 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.544007 #3925246] DEBUG -- : InvalidOption invalid option: --password=🔑
D, [2024-09-12T11:42:20.544048 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.544079 #3925246] DEBUG -- : After parse
D, [2024-09-12T11:42:20.544105 #3925246] DEBUG -- : remains: ["--url=https://12.xxx.xxx.44:443", "--username=test", "--password=🔑
D, [2024-09-12T11:42:20.544154 #3925246] DEBUG -- : plugin env created
D, [2024-09-12T11:42:20.544354 #3925246] DEBUG -- : (value) get version_check_days=7
D, [2024-09-12T11:42:20.544405 #3925246] DEBUG -- : persistency get: version_last_check
D, [2024-09-12T11:42:20.544485 #3925246] DEBUG -- : persistency = /.aspera/ascli/persist_store/version_last_check.txt
D, [2024-09-12T11:42:20.544522 #3925246] DEBUG -- : got from file cache
D, [2024-09-12T11:42:20.544653 #3925246] DEBUG -- : gem check new version: 7, 3/1, 2024-09-12, ["2024/09/09"]
D, [2024-09-12T11:42:20.544765 #3925246] DEBUG -- : command (Symbol)=shares
D, [2024-09-12T11:42:20.544800 #3925246] DEBUG -- : get_plugin_instance_with_options(shares)
D, [2024-09-12T11:42:20.544827 #3925246] DEBUG -- : add_plugin_default_preset:shares:
D, [2024-09-12T11:42:20.560320 #3925246] DEBUG -- : declare: url: value
D, [2024-09-12T11:42:20.560448 #3925246] DEBUG -- : on_args=["URL of application, e.g. https://faspex.example.com/aspera/faspex", "--url=VALUE"]
D, [2024-09-12T11:42:20.560505 #3925246] DEBUG -- : declare: username: value
D, [2024-09-12T11:42:20.560609 #3925246] DEBUG -- : on_args=["User's name to log in", "--username=VALUE"]
D, [2024-09-12T11:42:20.560654 #3925246] DEBUG -- : declare: password: 🔑
D, [2024-09-12T11:42:20.560763 #3925246] DEBUG -- : on_args=["User's password", "--password=🔑
D, [2024-09-12T11:42:20.560802 #3925246] DEBUG -- : parse_options!
D, [2024-09-12T11:42:20.560824 #3925246] DEBUG -- : consume_option_pairs: set
D, [2024-09-12T11:42:20.560875 #3925246] DEBUG -- : consume_option_pairs: env
D, [2024-09-12T11:42:20.560896 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.560990 #3925246] DEBUG -- : (value/cmdline) set url=https://12.xxx.xxx.44:443
D, [2024-09-12T11:42:20.561079 #3925246] DEBUG -- : (value/cmdline) set username=test
D, [2024-09-12T11:42:20.561167 #3925246] DEBUG -- : (value/cmdline) set password=🔑
D, [2024-09-12T11:42:20.561303 #3925246] DEBUG -- : After parse
D, [2024-09-12T11:42:20.561327 #3925246] DEBUG -- : remains: []
D, [2024-09-12T11:42:20.561348 #3925246] DEBUG -- : parse_options!
D, [2024-09-12T11:42:20.561366 #3925246] DEBUG -- : consume_option_pairs: set
D, [2024-09-12T11:42:20.561386 #3925246] DEBUG -- : consume_option_pairs: env
D, [2024-09-12T11:42:20.561405 #3925246] DEBUG -- : before parse
D, [2024-09-12T11:42:20.561431 #3925246] DEBUG -- : After parse
D, [2024-09-12T11:42:20.561481 #3925246] DEBUG -- : remains: []
D, [2024-09-12T11:42:20.561506 #3925246] DEBUG -- : (value) get lock_port=
D, [2024-09-12T11:42:20.561530 #3925246] DEBUG -- : (value) get pid_file=
D, [2024-09-12T11:42:20.561610 #3925246] DEBUG -- : command (Symbol)=files
D, [2024-09-12T11:42:20.561647 #3925246] DEBUG -- : (value) get url=https://12.xxx.xxx.44:443
D, [2024-09-12T11:42:20.561678 #3925246] DEBUG -- : (value) get username=test
D, [2024-09-12T11:42:20.561706 #3925246] DEBUG -- : (value) get password=🔑
D, [2024-09-12T11:42:20.561753 #3925246] DEBUG -- : Rest.new(https://12.xxx.xxx.44:443/node_api)
D, [2024-09-12T11:42:20.561847 #3925246] DEBUG -- : command (Symbol)=mkdir
D, [2024-09-12T11:42:20.562189 #3925246] DEBUG -- : folder path or ext.val. list (String)=["/share1/0912"]
D, [2024-09-12T11:42:20.562247 #3925246] DEBUG -- : POST [files/create]
D, [2024-09-12T11:42:20.562273 #3925246] DEBUG -- : using Basic auth
D, [2024-09-12T11:42:20.562345 #3925246] DEBUG -- : URI=https://12.xxx.xxx.44/node_api/files/create
D, [2024-09-12T11:42:20.562459 #3925246] DEBUG -- : req_body (json)=
"{\"paths\":[{\"type\":\"directory\",\"path\":\"/share1/0912\"}]}"
D, [2024-09-12T11:42:20.562504 #3925246] DEBUG -- : send request (retries=0)
WARNING: Ignoring certificate for: https://12.xxx.xxx.44:443. Do not deactivate certificate verification in production.
D, [2024-09-12T11:42:20.562623 #3925246] DEBUG -- : ignore cert? ["12.xxx.xxx.44", 443] -> true
D, [2024-09-12T11:42:20.698495 #3925246] DEBUG -- : result: code=200 mime=application/json
D, [2024-09-12T11:42:20.698620 #3925246] DEBUG -- : data (json)=
{
  "error": {
    "user_message": "Insufficient permissions"
  }
}
D, [2024-09-12T11:42:20.698732 #3925246] DEBUG -- : raise_on_error POST /node_api/files/create 200
ERROR: Rest: Insufficient permissions
/usr/share/gems/gems/aspera-cli-4.18.1/lib/aspera/rest_error_analyzer.rb:48:in `raise_on_error': Insufficient permissions (Aspera::RestCallError)
    from /usr/share/gems/gems/aspera-cli-4.18.1/lib/aspera/rest.rb:382:in `call'
    from /usr/share/gems/gems/aspera-cli-4.18.1/lib/aspera/rest.rb:427:in `create'
    from /usr/share/gems/gems/aspera-cli-4.18.1/lib/aspera/cli/plugins/node.rb:273:in `execute_command_gen3'
    from /usr/share/gems/gems/aspera-cli-4.18.1/lib/aspera/cli/plugins/node.rb:359:in `execute_simple_common'
    from /usr/share/gems/gems/aspera-cli-4.18.1/lib/aspera/cli/plugins/node.rb:734:in `execute_action'
    from /usr/share/gems/gems/aspera-cli-4.18.1/lib/aspera/cli/plugins/shares.rb:84:in `execute_action'
    from /usr/share/gems/gems/aspera-cli-4.18.1/lib/aspera/cli/main.rb:300:in `process_command_line'
    from /usr/share/gems/gems/aspera-cli-4.18.1/bin/ascli:24:in `<top (required)>'
    from /bin/ascli:23:in `load'
    from /bin/ascli:23:in `<main>'
laurent-martin commented 1 month ago

ascli only uses the APIs, and the API call is correct here.

It seems to be rather an inconsistency in Shares side:

Enter a ticket to IBM Aspera Support.

Note: It takes by default 10 minutes for changes in rights take 10 minutes to be active after change. This can be changed in the admin page, at least for testing.... (I changed to 1 min for the tests)