2024-06-12 23:08:44.870 | ERROR | metagpt.utils.common:log_it:554 - Finished call to 'metagpt.actions.action_node.ActionNode._aask_v1' after 12.079(s), this was the 5th time calling it. exp: RetryError[<Future at 0x22e7bd4da10 state=finished raised JSONDecodeError>]
2024-06-12 23:08:52.188 | WARNING | metagpt.provider.openai_api:_calc_usage:244 - usage calculation failed: num_tokens_from_messages() is not implemented for model gpt-4-turbo. See https://cookbook.openai.com/examples/how_to_count_tokens_with_tiktoken for information on how messages are converted to tokens.
2024-06-12 23:08:52.195 | WARNING | metagpt.utils.repair_llm_raw_output:extract_content_from_output:320 - extract_content try another pattern: [CONTENT]([\s\S])[/CONTENT]
2024-06-12 23:08:52.197 | WARNING | metagpt.utils.repair_llm_raw_output:run_and_passon:268 - parse json from content inside [CONTENT][/CONTENT] failed at retry 1, exp: Expecting value: line 1 column 2 (char 1)
2024-06-12 23:08:52.199 | INFO | metagpt.utils.repair_llm_raw_output:repair_invalid_json:237 - repair_invalid_json, raw error: Expecting value: line 1 column 2 (char 1)
2024-06-12 23:08:52.201 | ERROR | metagpt.utils.common:log_it:554 - Finished call to 'metagpt.actions.action_node.ActionNode._aask_v1' after 19.422(s), this was the 6th time calling it. exp: RetryError[<Future at 0x22e7bd4d350 state=finished raised JSONDecodeError>]
2024-06-12 23:08:52.205 | WARNING | metagpt.utils.common:wrapper:649 - There is a exception in role's execution, in order to resume, we delete the newest role communication message in the role's memory.
2024-06-12 23:08:52.212 | ERROR | metagpt.utils.common:wrapper:631 - Exception occurs, start to serialize the project, exp:
Traceback (most recent call last):
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init.py", line 382, in call__
result = fn(args, **kwargs)
^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\repair_llm_raw_output.py", line 296, in retry_parse_json_text
parsed_data = CustomDecoder(strict=False).decode(output)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
json.decoder.JSONDecodeError: Expecting value: line 1 column 2 (char 1)
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity_asyncio.py", line 50, in call
result = await fn(*args, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\action_node.py", line 425, in _aask_v1
parsed_data = llm_output_postprocess(
^^^^^^^^^^^^^^^^^^^^^^^
tenacity.RetryError: RetryError[<Future at 0x22e7bd4d350 state=finished raised JSONDecodeError>]
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\common.py", line 640, in wrapper
return await func(self, *args, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 550, in run
rsp = await self.react()
^^^^^^^^^^^^^^^^^^
tenacity.RetryError: RetryError[<Future at 0x22e7bd4f190 state=finished raised RetryError>]
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\common.py", line 626, in wrapper
result = await func(self, *args, *kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\team.py", line 134, in run
await self.env.run()
Exception: Traceback (most recent call last):
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init.py", line 382, in call__
result = fn(args, **kwargs)
^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\repair_llm_raw_output.py", line 296, in retry_parse_json_text
parsed_data = CustomDecoder(strict=False).decode(output)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\custom_decoder.py", line 297, in decode
return super().decode(s)
^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\json\decoder.py", line 337, in decode
obj, end = self.raw_decode(s, idx=_w(s, 0).end())
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\json\decoder.py", line 353, in raw_decode
obj, end = self.scan_once(s, idx)
^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\custom_decoder.py", line 65, in scan_once
return _scan_once(string, idx)
^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\custom_decoder.py", line 38, in _scan_once
return parse_array((string, idx + 1), _scan_once)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\json\decoder.py", line 232, in JSONArray
raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 2 (char 1)
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity_asyncio.py", line 50, in call
result = await fn(*args, *kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\action_node.py", line 425, in _aask_v1
parsed_data = llm_output_postprocess(
^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\provider\postprocess\llm_output_postprocess.py", line 19, in llm_output_postprocess
result = postprocess_plugin.run(output=output, schema=schema, req_key=req_key)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\provider\postprocess\base_postprocess_plugin.py", line 68, in run
new_output = self.run_repair_llm_output(output=output, schema=schema, req_key=req_key)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\provider\postprocess\base_postprocess_plugin.py", line 32, in run_repair_llm_output
parsed_data = self.run_retry_parse_json_text(content)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\provider\postprocess\base_postprocess_plugin.py", line 47, in run_retry_parse_json_text
parsed_data = retry_parse_json_text(output=content) # should use output=content
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init__.py", line 289, in wrapped_f
return self(f, args, **kw)
^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init.py", line 379, in call
do = self.iter(retry_state=retry_state)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity\init__.py", line 326, in iter
raise retry_exc from fut.exception()
tenacity.RetryError: RetryError[<Future at 0x22e7bd4d350 state=finished raised JSONDecodeError>]
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\common.py", line 640, in wrapper
return await func(self, *args, *kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 550, in run
rsp = await self.react()
^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 517, in react
rsp = await self._react()
^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 463, in _react
rsp = await self._act()
^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 392, in _act
response = await self.rc.todo.run(self.rc.history)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\write_prd.py", line 87, in run
return await self._handle_new_requirement(req)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\write_prd.py", line 108, in _handle_new_requirement
node = await WRITE_PRD_NODE.fill(context=context, llm=self.llm, exclude=exclude) # schema=schema
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\action_node.py", line 505, in fill
return await self.simple_fill(schema=schema, mode=mode, images=images, timeout=timeout, exclude=exclude)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\action_node.py", line 457, in simple_fill
content, scontent = await self._aask_v1(
^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity_asyncio.py", line 88, in async_wrapped
return await fn(args, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity_asyncio.py", line 47, in call
do = self.iter(retry_state=retry_state)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init__.py", line 326, in iter
raise retry_exc from fut.exception()
tenacity.RetryError: RetryError[<Future at 0x22e7bd4f190 state=finished raised RetryError>]
zhenglanglang
commented
3 months ago
2024-06-12 23:08:44.870 | ERROR | metagpt.utils.common:log_it:554 - Finished call to 'metagpt.actions.action_node.ActionNode._aask_v1' after 12.079(s), this was the 5th time calling it. exp: RetryError[<Future at 0x22e7bd4da10 state=finished raised JSONDecodeError>]
2024-06-12 23:08:52.188 | WARNING | metagpt.provider.openai_api:_calc_usage:244 - usage calculation failed: num_tokens_from_messages() is not implemented for model gpt-4-turbo. See https://cookbook.openai.com/examples/how_to_count_tokens_with_tiktoken for information on how messages are converted to tokens. 2024-06-12 23:08:52.195 | WARNING | metagpt.utils.repair_llm_raw_output:extract_content_from_output:320 - extract_content try another pattern: [CONTENT]([\s\S])[/CONTENT] 2024-06-12 23:08:52.197 | WARNING | metagpt.utils.repair_llm_raw_output:run_and_passon:268 - parse json from content inside [CONTENT][/CONTENT] failed at retry 1, exp: Expecting value: line 1 column 2 (char 1) 2024-06-12 23:08:52.199 | INFO | metagpt.utils.repair_llm_raw_output:repair_invalid_json:237 - repair_invalid_json, raw error: Expecting value: line 1 column 2 (char 1) 2024-06-12 23:08:52.201 | ERROR | metagpt.utils.common:log_it:554 - Finished call to 'metagpt.actions.action_node.ActionNode._aask_v1' after 19.422(s), this was the 6th time calling it. exp: RetryError[<Future at 0x22e7bd4d350 state=finished raised JSONDecodeError>] 2024-06-12 23:08:52.205 | WARNING | metagpt.utils.common:wrapper:649 - There is a exception in role's execution, in order to resume, we delete the newest role communication message in the role's memory. 2024-06-12 23:08:52.212 | ERROR | metagpt.utils.common:wrapper:631 - Exception occurs, start to serialize the project, exp: Traceback (most recent call last): File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init.py", line 382, in call__ result = fn(args, **kwargs) ^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\repair_llm_raw_output.py", line 296, in retry_parse_json_text parsed_data = CustomDecoder(strict=False).decode(output) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ json.decoder.JSONDecodeError: Expecting value: line 1 column 2 (char 1)
The above exception was the direct cause of the following exception:
Traceback (most recent call last): File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity_asyncio.py", line 50, in call result = await fn(*args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\action_node.py", line 425, in _aask_v1 parsed_data = llm_output_postprocess( ^^^^^^^^^^^^^^^^^^^^^^^ tenacity.RetryError: RetryError[<Future at 0x22e7bd4d350 state=finished raised JSONDecodeError>]
The above exception was the direct cause of the following exception:
Traceback (most recent call last): File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\common.py", line 640, in wrapper return await func(self, *args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 550, in run rsp = await self.react() ^^^^^^^^^^^^^^^^^^ tenacity.RetryError: RetryError[<Future at 0x22e7bd4f190 state=finished raised RetryError>]
During handling of the above exception, another exception occurred:
Traceback (most recent call last): File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\common.py", line 626, in wrapper result = await func(self, *args, *kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\team.py", line 134, in run await self.env.run() Exception: Traceback (most recent call last): File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init.py", line 382, in call__ result = fn(args, **kwargs) ^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\repair_llm_raw_output.py", line 296, in retry_parse_json_text parsed_data = CustomDecoder(strict=False).decode(output) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\custom_decoder.py", line 297, in decode return super().decode(s) ^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\json\decoder.py", line 337, in decode obj, end = self.raw_decode(s, idx=_w(s, 0).end()) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\json\decoder.py", line 353, in raw_decode obj, end = self.scan_once(s, idx) ^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\custom_decoder.py", line 65, in scan_once return _scan_once(string, idx) ^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\custom_decoder.py", line 38, in _scan_once return parse_array((string, idx + 1), _scan_once) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\json\decoder.py", line 232, in JSONArray raise JSONDecodeError("Expecting value", s, err.value) from None json.decoder.JSONDecodeError: Expecting value: line 1 column 2 (char 1)
The above exception was the direct cause of the following exception:
Traceback (most recent call last): File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity_asyncio.py", line 50, in call result = await fn(*args, *kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\action_node.py", line 425, in _aask_v1 parsed_data = llm_output_postprocess( ^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\provider\postprocess\llm_output_postprocess.py", line 19, in llm_output_postprocess result = postprocess_plugin.run(output=output, schema=schema, req_key=req_key) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\provider\postprocess\base_postprocess_plugin.py", line 68, in run new_output = self.run_repair_llm_output(output=output, schema=schema, req_key=req_key) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\provider\postprocess\base_postprocess_plugin.py", line 32, in run_repair_llm_output parsed_data = self.run_retry_parse_json_text(content) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\provider\postprocess\base_postprocess_plugin.py", line 47, in run_retry_parse_json_text parsed_data = retry_parse_json_text(output=content) # should use output=content ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init__.py", line 289, in wrapped_f return self(f, args, **kw) ^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init.py", line 379, in call do = self.iter(retry_state=retry_state) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity\init__.py", line 326, in iter raise retry_exc from fut.exception() tenacity.RetryError: RetryError[<Future at 0x22e7bd4d350 state=finished raised JSONDecodeError>]
The above exception was the direct cause of the following exception:
Traceback (most recent call last): File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\utils\common.py", line 640, in wrapper return await func(self, *args, *kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 550, in run rsp = await self.react() ^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 517, in react rsp = await self._react() ^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 463, in _react rsp = await self._act() ^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\roles\role.py", line 392, in _act response = await self.rc.todo.run(self.rc.history) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\write_prd.py", line 87, in run return await self._handle_new_requirement(req) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\write_prd.py", line 108, in _handle_new_requirement node = await WRITE_PRD_NODE.fill(context=context, llm=self.llm, exclude=exclude) # schema=schema ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\action_node.py", line 505, in fill return await self.simple_fill(schema=schema, mode=mode, images=images, timeout=timeout, exclude=exclude) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\metagpt\actions\action_node.py", line 457, in simple_fill content, scontent = await self._aask_v1( ^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity_asyncio.py", line 88, in async_wrapped return await fn(args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity_asyncio.py", line 47, in call do = self.iter(retry_state=retry_state) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "D:\Users\anaconda3\envs\yolome\Lib\site-packages\tenacity__init__.py", line 326, in iter raise retry_exc from fut.exception() tenacity.RetryError: RetryError[<Future at 0x22e7bd4f190 state=finished raised RetryError>]